builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0091 starttime: 1487358932.03 results: success (0) buildid: 20170217083319 builduid: b54d30aee3764af491c73a59f046b8ec revision: dd50cacb9a992168c4d78e049f06eb098aee6f58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:32.028363) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:32.028849) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:32.029135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:32.057237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:32.057601) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lMxpRE7g1M/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-17 11:15:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 39.8M=0s 2017-02-17 11:15:32 (39.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.170750 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:32.254992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:32.255330) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lMxpRE7g1M/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025854 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:32.303627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 11:15:32.307030) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dd50cacb9a992168c4d78e049f06eb098aee6f58 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dd50cacb9a992168c4d78e049f06eb098aee6f58 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lMxpRE7g1M/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-17 11:15:32,417 truncating revision to first 12 chars 2017-02-17 11:15:32,417 Setting DEBUG logging. 2017-02-17 11:15:32,417 attempt 1/10 2017-02-17 11:15:32,417 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dd50cacb9a99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-17 11:15:33,819 unpacking tar archive at: mozilla-beta-dd50cacb9a99/testing/mozharness/ program finished with exit code 0 elapsedTime=1.676381 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 11:15:34.009049) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:34.009402) ========= script_repo_revision: dd50cacb9a992168c4d78e049f06eb098aee6f58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:34.009806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:34.010082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 11:15:34.030276) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-17 11:15:34.030662) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lMxpRE7g1M/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:15:34 INFO - MultiFileLogger online at 20170217 11:15:34 in /builds/slave/test 11:15:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:15:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:15:34 INFO - {'append_to_log': False, 11:15:34 INFO - 'base_work_dir': '/builds/slave/test', 11:15:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:15:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:15:34 INFO - 'branch': 'Mozilla-Beta', 11:15:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:15:34 INFO - 'config_files': ('talos/mac_config.py',), 11:15:34 INFO - 'default_actions': ('clobber', 11:15:34 INFO - 'read-buildbot-config', 11:15:34 INFO - 'download-and-extract', 11:15:34 INFO - 'populate-webroot', 11:15:34 INFO - 'create-virtualenv', 11:15:34 INFO - 'install', 11:15:34 INFO - 'run-tests'), 11:15:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:15:34 INFO - 'download_minidump_stackwalk': True, 11:15:34 INFO - 'download_symbols': 'ondemand', 11:15:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:15:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:15:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:15:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:15:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:15:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:15:34 INFO - 'installer_path': 'installer.exe', 11:15:34 INFO - 'log_level': 'info', 11:15:34 INFO - 'log_name': 'talos', 11:15:34 INFO - 'log_to_console': True, 11:15:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:15:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:15:34 INFO - 'opt_config_files': (), 11:15:34 INFO - 'pip_index': False, 11:15:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:15:34 INFO - 'cmd': ('bash', 11:15:34 INFO - '-c', 11:15:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:15:34 INFO - 'enabled': True, 11:15:34 INFO - 'halt_on_failure': False, 11:15:34 INFO - 'name': 'check_screen_resolution'},), 11:15:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:15:34 INFO - 'cmd': ('bash', 11:15:34 INFO - '-c', 11:15:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:15:34 INFO - 'enabled': True, 11:15:34 INFO - 'halt_on_failure': False, 11:15:34 INFO - 'name': 'check_screen_resolution'},), 11:15:34 INFO - 'run_cmd_checks_enabled': True, 11:15:34 INFO - 'sps_profile': False, 11:15:34 INFO - 'sps_profile_interval': 0, 11:15:34 INFO - 'suite': 'dromaeojs', 11:15:34 INFO - 'system_bits': '32', 11:15:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:15:34 INFO - 'title': 't-yosemite-r7-0091', 11:15:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:15:34 INFO - 'use_talos_json': True, 11:15:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:15:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:15:34 INFO - 'work_dir': 'build'} 11:15:34 INFO - [mozharness: 2017-02-17 19:15:34.246338Z] Running clobber step. 11:15:34 INFO - Running pre-action listener: _resource_record_pre_action 11:15:34 INFO - Running main action method: clobber 11:15:34 INFO - rmtree: /builds/slave/test/build 11:15:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:15:36 INFO - Running post-action listener: _resource_record_post_action 11:15:36 INFO - [mozharness: 2017-02-17 19:15:36.707480Z] Finished clobber step (success) 11:15:36 INFO - [mozharness: 2017-02-17 19:15:36.707629Z] Running read-buildbot-config step. 11:15:36 INFO - Running pre-action listener: _resource_record_pre_action 11:15:36 INFO - Running main action method: read_buildbot_config 11:15:36 INFO - Using buildbot properties: 11:15:36 INFO - { 11:15:36 INFO - "project": "", 11:15:36 INFO - "product": "firefox", 11:15:36 INFO - "script_repo_revision": "production", 11:15:36 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:15:36 INFO - "repository": "", 11:15:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:15:36 INFO - "buildid": "20170217083319", 11:15:36 INFO - "pgo_build": "False", 11:15:36 INFO - "basedir": "/builds/slave/test", 11:15:36 INFO - "buildnumber": 5, 11:15:36 INFO - "slavename": "t-yosemite-r7-0091", 11:15:36 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:15:36 INFO - "platform": "yosemite_r7", 11:15:36 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:15:36 INFO - "branch": "mozilla-beta", 11:15:36 INFO - "repo_path": "releases/mozilla-beta", 11:15:36 INFO - "revision": "dd50cacb9a992168c4d78e049f06eb098aee6f58", 11:15:36 INFO - "stage_platform": "macosx64", 11:15:36 INFO - "builduid": "b54d30aee3764af491c73a59f046b8ec", 11:15:36 INFO - "slavebuilddir": "test" 11:15:36 INFO - } 11:15:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 11:15:36 INFO - Running post-action listener: _resource_record_post_action 11:15:36 INFO - [mozharness: 2017-02-17 19:15:36.710972Z] Finished read-buildbot-config step (success) 11:15:36 INFO - [mozharness: 2017-02-17 19:15:36.711110Z] Running download-and-extract step. 11:15:36 INFO - Running pre-action listener: _resource_record_pre_action 11:15:36 INFO - Running main action method: download_and_extract 11:15:36 INFO - mkdir: /builds/slave/test/build/tests 11:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:36 INFO - trying https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 11:15:36 INFO - Downloading https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:15:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 11:15:38 INFO - Downloaded 1165 bytes. 11:15:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:15:38 INFO - Using the following test package requirements: 11:15:38 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:15:38 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:15:38 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 11:15:38 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:15:38 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 11:15:38 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:15:38 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:15:38 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 11:15:38 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:15:38 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:15:38 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 11:15:38 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:15:38 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 11:15:38 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:15:38 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 11:15:38 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:15:38 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 11:15:38 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 11:15:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:15:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:15:38 INFO - Fetch https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:15:38 INFO - Http code: 200 11:15:38 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 11:15:38 INFO - x-amz-cf-id: hpR7cBTEhQL1beqQXq_MgFlLMws3UPzufgg7kVu0-aM1vpkFkhxwMw== 11:15:38 INFO - x-amz-version-id: oBYmdoRN6ItMBGMiwi2lJPy_dVpBEfzP 11:15:39 INFO - Expected file size: 16093123 11:15:39 INFO - Obtained file size: 16093123 11:15:45 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:15:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:15:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:15:45 INFO - Fetch https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:15:46 INFO - Http code: 200 11:15:46 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 11:15:46 INFO - x-amz-cf-id: pbvIQ9JNgx4PCZyBDaYLDzmjbEhDe72nedEnMrW-Mh5nY0puUpphsQ== 11:15:46 INFO - x-amz-version-id: oBYmdoRN6ItMBGMiwi2lJPy_dVpBEfzP 11:15:46 INFO - Expected file size: 16093123 11:15:46 INFO - Obtained file size: 16093123 11:15:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 11:15:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 11:15:52 INFO - Fetch https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 11:15:53 INFO - Http code: 200 11:15:53 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 11:15:53 INFO - x-amz-cf-id: xi2nZFl-T2r1ME4XG9LrL-4ETG0z430Pc-YzVWcMbSO0X_rRwI4IXQ== 11:15:53 INFO - x-amz-version-id: ueNbJ0XpuetOHwj88IwzyO_W3XMun6X0 11:15:54 INFO - Expected file size: 14403005 11:15:54 INFO - Obtained file size: 14403005 11:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:54 INFO - trying https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:15:54 INFO - Downloading https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 11:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 11:15:57 INFO - Downloaded 82138069 bytes. 11:15:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:15:57 INFO - mkdir: /builds/slave/test/properties 11:15:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:57 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:57 INFO - Contents: 11:15:57 INFO - build_url:https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:15:58 INFO - Running post-action listener: _resource_record_post_action 11:15:58 INFO - Running post-action listener: set_extra_try_arguments 11:15:58 INFO - [mozharness: 2017-02-17 19:15:58.244247Z] Finished download-and-extract step (success) 11:15:58 INFO - [mozharness: 2017-02-17 19:15:58.244375Z] Running populate-webroot step. 11:15:58 INFO - Running pre-action listener: _resource_record_pre_action 11:15:58 INFO - Running main action method: populate_webroot 11:15:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:15:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:15:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:15:58 INFO - '--tppagecycles', 11:15:58 INFO - '7'], 11:15:58 INFO - 'tests': ['tsvgm']}}, 11:15:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:15:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:15:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:15:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:15:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:58 INFO - 'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:58 INFO - 'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['damp', 'tps']}, 11:15:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:58 INFO - 'tests': ['damp', 'tps']}, 11:15:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['dromaeo_dom']}, 11:15:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['basic_compositor_video']}, 11:15:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:15:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['a11yr', 11:15:58 INFO - 'ts_paint', 11:15:58 INFO - 'tpaint', 11:15:58 INFO - 'sessionrestore', 11:15:58 INFO - 'sessionrestore_no_auto_restore', 11:15:58 INFO - 'tabpaint']}, 11:15:58 INFO - 'other-e10s': {'tests': ['a11yr', 11:15:58 INFO - 'ts_paint', 11:15:58 INFO - 'tpaint', 11:15:58 INFO - 'sessionrestore', 11:15:58 INFO - 'sessionrestore_no_auto_restore', 11:15:58 INFO - 'tabpaint']}, 11:15:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:15:58 INFO - 'ts_paint', 11:15:58 INFO - 'tpaint', 11:15:58 INFO - 'sessionrestore', 11:15:58 INFO - 'sessionrestore_no_auto_restore', 11:15:58 INFO - 'tabpaint']}, 11:15:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:15:58 INFO - 'ts_paint', 11:15:58 INFO - 'tpaint', 11:15:58 INFO - 'sessionrestore', 11:15:58 INFO - 'sessionrestore_no_auto_restore', 11:15:58 INFO - 'tabpaint']}, 11:15:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['a11yr', 11:15:58 INFO - 'ts_paint', 11:15:58 INFO - 'tpaint', 11:15:58 INFO - 'sessionrestore', 11:15:58 INFO - 'sessionrestore_no_auto_restore', 11:15:58 INFO - 'tabpaint']}, 11:15:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['a11yr', 11:15:58 INFO - 'ts_paint', 11:15:58 INFO - 'tpaint', 11:15:58 INFO - 'sessionrestore', 11:15:58 INFO - 'sessionrestore_no_auto_restore', 11:15:58 INFO - 'tabpaint']}, 11:15:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['tsvgx', 11:15:58 INFO - 'tsvgr_opacity', 11:15:58 INFO - 'tart', 11:15:58 INFO - 'tscrollx', 11:15:58 INFO - 'cart']}, 11:15:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:15:58 INFO - 'tsvgr_opacity', 11:15:58 INFO - 'tart', 11:15:58 INFO - 'tscrollx', 11:15:58 INFO - 'cart']}, 11:15:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:58 INFO - 'talos_options': ['--disable-e10s'], 11:15:58 INFO - 'tests': ['tp5o']}, 11:15:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:58 INFO - 'tests': ['tp5o']}, 11:15:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:58 INFO - 'talos_options': ['--disable-e10s', 11:15:58 INFO - '--xperf_path', 11:15:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:58 INFO - 'tests': ['tp5n']}, 11:15:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:58 INFO - 'talos_options': ['--xperf_path', 11:15:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:58 INFO - 'tests': ['tp5n']}}, 11:15:58 INFO - 'talos.zip': {'path': '', 11:15:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:15:58 INFO - Running post-action listener: _resource_record_post_action 11:15:58 INFO - [mozharness: 2017-02-17 19:15:58.263275Z] Finished populate-webroot step (success) 11:15:58 INFO - [mozharness: 2017-02-17 19:15:58.263375Z] Running create-virtualenv step. 11:15:58 INFO - Running pre-action listener: _resource_record_pre_action 11:15:58 INFO - Running main action method: create_virtualenv 11:15:58 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:15:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:15:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:58 INFO - Using real prefix '/tools/python27' 11:15:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:59 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:01 INFO - Installing pip.................done. 11:16:01 INFO - Return code: 0 11:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:16:02 INFO - Reading from file tmpfile_stdout 11:16:02 INFO - Output received: 11:16:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:16:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10386d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80fac647e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:16:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:02 INFO - 'HOME': '/Users/cltbld', 11:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:02 INFO - 'LOGNAME': 'cltbld', 11:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:02 INFO - 'MOZ_NO_REMOTE': '1', 11:16:02 INFO - 'NO_EM_RESTART': '1', 11:16:02 INFO - 'PAGER': '/bin/cat', 11:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:02 INFO - 'PWD': '/builds/slave/test', 11:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:02 INFO - 'SHELL': '/bin/bash', 11:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:02 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:02 INFO - 'USER': 'cltbld', 11:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:02 INFO - 'XPC_FLAGS': '0x0', 11:16:02 INFO - 'XPC_SERVICE_NAME': '0', 11:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:16:02 INFO - Cleaning up... 11:16:02 INFO - Return code: 0 11:16:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10386d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80fac647e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:16:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:02 INFO - 'HOME': '/Users/cltbld', 11:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:02 INFO - 'LOGNAME': 'cltbld', 11:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:02 INFO - 'MOZ_NO_REMOTE': '1', 11:16:02 INFO - 'NO_EM_RESTART': '1', 11:16:02 INFO - 'PAGER': '/bin/cat', 11:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:02 INFO - 'PWD': '/builds/slave/test', 11:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:02 INFO - 'SHELL': '/bin/bash', 11:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:02 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:02 INFO - 'USER': 'cltbld', 11:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:02 INFO - 'XPC_FLAGS': '0x0', 11:16:02 INFO - 'XPC_SERVICE_NAME': '0', 11:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:02 INFO - Downloading/unpacking psutil>=3.1.1 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:16:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:06 INFO - Installing collected packages: psutil 11:16:06 INFO - Running setup.py install for psutil 11:16:06 INFO - building 'psutil._psutil_osx' extension 11:16:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:16:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:16:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:16:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:16:07 INFO - building 'psutil._psutil_posix' extension 11:16:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:16:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:16:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:16:07 INFO - ^ 11:16:07 INFO - 1 warning generated. 11:16:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:16:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:07 INFO - Successfully installed psutil 11:16:07 INFO - Cleaning up... 11:16:07 INFO - Return code: 0 11:16:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10386d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80fac647e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:07 INFO - 'HOME': '/Users/cltbld', 11:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:07 INFO - 'LOGNAME': 'cltbld', 11:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:07 INFO - 'MOZ_NO_REMOTE': '1', 11:16:07 INFO - 'NO_EM_RESTART': '1', 11:16:07 INFO - 'PAGER': '/bin/cat', 11:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:07 INFO - 'PWD': '/builds/slave/test', 11:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:07 INFO - 'SHELL': '/bin/bash', 11:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:07 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:07 INFO - 'USER': 'cltbld', 11:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:07 INFO - 'XPC_FLAGS': '0x0', 11:16:07 INFO - 'XPC_SERVICE_NAME': '0', 11:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:16:10 INFO - Installing collected packages: mozsystemmonitor 11:16:10 INFO - Running setup.py install for mozsystemmonitor 11:16:10 INFO - Successfully installed mozsystemmonitor 11:16:10 INFO - Cleaning up... 11:16:10 INFO - Return code: 0 11:16:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10386d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80fac647e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:16:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:10 INFO - 'HOME': '/Users/cltbld', 11:16:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:10 INFO - 'LOGNAME': 'cltbld', 11:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:10 INFO - 'MOZ_NO_REMOTE': '1', 11:16:10 INFO - 'NO_EM_RESTART': '1', 11:16:10 INFO - 'PAGER': '/bin/cat', 11:16:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:10 INFO - 'PWD': '/builds/slave/test', 11:16:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:10 INFO - 'SHELL': '/bin/bash', 11:16:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:10 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:10 INFO - 'USER': 'cltbld', 11:16:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:10 INFO - 'XPC_FLAGS': '0x0', 11:16:10 INFO - 'XPC_SERVICE_NAME': '0', 11:16:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:10 INFO - Downloading/unpacking jsonschema==2.5.1 11:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:16:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:13 INFO - Downloading functools32-3.2.3-2.tar.gz 11:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:16:14 INFO - warning: no files found matching '*.txt' 11:16:14 INFO - no previously-included directories found matching 'build' 11:16:14 INFO - no previously-included directories found matching 'dist' 11:16:14 INFO - no previously-included directories found matching '.git*' 11:16:14 INFO - Installing collected packages: jsonschema, functools32 11:16:14 INFO - Running setup.py install for functools32 11:16:14 INFO - warning: no files found matching '*.txt' 11:16:14 INFO - no previously-included directories found matching 'build' 11:16:14 INFO - no previously-included directories found matching 'dist' 11:16:14 INFO - no previously-included directories found matching '.git*' 11:16:14 INFO - Successfully installed jsonschema functools32 11:16:14 INFO - Cleaning up... 11:16:14 INFO - Return code: 0 11:16:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10386d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80fac647e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:14 INFO - 'HOME': '/Users/cltbld', 11:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:14 INFO - 'LOGNAME': 'cltbld', 11:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:14 INFO - 'MOZ_NO_REMOTE': '1', 11:16:14 INFO - 'NO_EM_RESTART': '1', 11:16:14 INFO - 'PAGER': '/bin/cat', 11:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:14 INFO - 'PWD': '/builds/slave/test', 11:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:14 INFO - 'SHELL': '/bin/bash', 11:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:14 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:14 INFO - 'USER': 'cltbld', 11:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:14 INFO - 'XPC_FLAGS': '0x0', 11:16:14 INFO - 'XPC_SERVICE_NAME': '0', 11:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:16:14 INFO - Cleaning up... 11:16:14 INFO - Return code: 0 11:16:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10386d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80fac647e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:14 INFO - 'HOME': '/Users/cltbld', 11:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:14 INFO - 'LOGNAME': 'cltbld', 11:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:14 INFO - 'MOZ_NO_REMOTE': '1', 11:16:14 INFO - 'NO_EM_RESTART': '1', 11:16:14 INFO - 'PAGER': '/bin/cat', 11:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:14 INFO - 'PWD': '/builds/slave/test', 11:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:14 INFO - 'SHELL': '/bin/bash', 11:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:14 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:14 INFO - 'USER': 'cltbld', 11:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:14 INFO - 'XPC_FLAGS': '0x0', 11:16:14 INFO - 'XPC_SERVICE_NAME': '0', 11:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:14 INFO - Downloading/unpacking blobuploader==1.2.4 11:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:17 INFO - Downloading blobuploader-1.2.4.tar.gz 11:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:16:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:16:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:18 INFO - Downloading docopt-0.6.1.tar.gz 11:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:18 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:18 INFO - Running setup.py install for blobuploader 11:16:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:16:18 INFO - Running setup.py install for requests 11:16:19 INFO - Running setup.py install for docopt 11:16:19 INFO - Successfully installed blobuploader requests docopt 11:16:19 INFO - Cleaning up... 11:16:19 INFO - Return code: 0 11:16:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10386d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80fac647e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:16:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:19 INFO - 'HOME': '/Users/cltbld', 11:16:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:19 INFO - 'LOGNAME': 'cltbld', 11:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:19 INFO - 'MOZ_NO_REMOTE': '1', 11:16:19 INFO - 'NO_EM_RESTART': '1', 11:16:19 INFO - 'PAGER': '/bin/cat', 11:16:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:19 INFO - 'PWD': '/builds/slave/test', 11:16:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:19 INFO - 'SHELL': '/bin/bash', 11:16:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:19 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:19 INFO - 'USER': 'cltbld', 11:16:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:19 INFO - 'XPC_FLAGS': '0x0', 11:16:19 INFO - 'XPC_SERVICE_NAME': '0', 11:16:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:19 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-qjKBYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:20 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-cY97V6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:20 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-MXDO8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:20 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-_LRd3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:20 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-VXqdmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:20 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-7dxTuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:20 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-Smubwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:20 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-Gz_56w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:20 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-vsBYu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:20 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-ucS0x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:21 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-u4ieti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:21 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-4nB0Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:21 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-H0UPhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:21 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-YuaWQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:21 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-BAjXAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:21 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-TWeJJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:21 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-Tbaf7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:21 INFO - Running setup.py install for manifestparser 11:16:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:16:21 INFO - Running setup.py install for mozcrash 11:16:22 INFO - Running setup.py install for mozdebug 11:16:22 INFO - Running setup.py install for mozdevice 11:16:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Running setup.py install for mozfile 11:16:22 INFO - Running setup.py install for mozhttpd 11:16:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Running setup.py install for mozinfo 11:16:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Running setup.py install for mozInstall 11:16:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Running setup.py install for mozleak 11:16:23 INFO - Running setup.py install for mozlog 11:16:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:16:23 INFO - Running setup.py install for moznetwork 11:16:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:16:23 INFO - Running setup.py install for mozprocess 11:16:23 INFO - Running setup.py install for mozprofile 11:16:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:16:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:16:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:16:23 INFO - Running setup.py install for mozrunner 11:16:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:16:23 INFO - Running setup.py install for mozscreenshot 11:16:24 INFO - Running setup.py install for moztest 11:16:24 INFO - Running setup.py install for mozversion 11:16:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:16:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:16:24 INFO - Cleaning up... 11:16:24 INFO - Return code: 0 11:16:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10386d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80fac647e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:16:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:24 INFO - 'HOME': '/Users/cltbld', 11:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:24 INFO - 'LOGNAME': 'cltbld', 11:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:24 INFO - 'MOZ_NO_REMOTE': '1', 11:16:24 INFO - 'NO_EM_RESTART': '1', 11:16:24 INFO - 'PAGER': '/bin/cat', 11:16:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:24 INFO - 'PWD': '/builds/slave/test', 11:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:24 INFO - 'SHELL': '/bin/bash', 11:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:24 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:24 INFO - 'USER': 'cltbld', 11:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:24 INFO - 'XPC_FLAGS': '0x0', 11:16:24 INFO - 'XPC_SERVICE_NAME': '0', 11:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:24 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-O3MUmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:24 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-x8kp7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:24 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-zyU1XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:24 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-IhpaVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:25 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-H3lIQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:25 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-h0a176-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:25 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-pF2RmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:25 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-HbZjTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:25 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-Re84GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:25 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-aHDQil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:25 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-WPoZPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:25 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-GAL8yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:25 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-wQ5B8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:26 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-Ykl6QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:26 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-WehFQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:26 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-P8WEon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:26 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-aFBi8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:16:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:29 INFO - Downloading blessings-1.6.tar.gz 11:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:16:29 INFO - Installing collected packages: blessings 11:16:29 INFO - Running setup.py install for blessings 11:16:29 INFO - Successfully installed blessings 11:16:29 INFO - Cleaning up... 11:16:29 INFO - Return code: 0 11:16:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:29 INFO - Reading from file tmpfile_stdout 11:16:29 INFO - Current package versions: 11:16:29 INFO - blessings == 1.6 11:16:29 INFO - blobuploader == 1.2.4 11:16:29 INFO - docopt == 0.6.1 11:16:29 INFO - functools32 == 3.2.3-2 11:16:29 INFO - jsonschema == 2.5.1 11:16:29 INFO - manifestparser == 1.1 11:16:29 INFO - mozInstall == 1.12 11:16:29 INFO - mozcrash == 1.0 11:16:29 INFO - mozdebug == 0.1 11:16:29 INFO - mozdevice == 0.48 11:16:29 INFO - mozfile == 1.2 11:16:29 INFO - mozhttpd == 0.7 11:16:29 INFO - mozinfo == 0.9 11:16:29 INFO - mozleak == 0.1 11:16:29 INFO - mozlog == 3.4 11:16:29 INFO - moznetwork == 0.27 11:16:29 INFO - mozprocess == 0.23 11:16:29 INFO - mozprofile == 0.28 11:16:29 INFO - mozrunner == 6.13 11:16:29 INFO - mozscreenshot == 0.1 11:16:29 INFO - mozsystemmonitor == 0.3 11:16:29 INFO - moztest == 0.8 11:16:29 INFO - mozversion == 1.4 11:16:29 INFO - psutil == 3.1.1 11:16:29 INFO - requests == 1.2.3 11:16:29 INFO - wsgiref == 0.1.2 11:16:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10386d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80fac647e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:16:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:16:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:30 INFO - 'HOME': '/Users/cltbld', 11:16:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:30 INFO - 'LOGNAME': 'cltbld', 11:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:30 INFO - 'MOZ_NO_REMOTE': '1', 11:16:30 INFO - 'NO_EM_RESTART': '1', 11:16:30 INFO - 'PAGER': '/bin/cat', 11:16:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:30 INFO - 'PWD': '/builds/slave/test', 11:16:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:30 INFO - 'SHELL': '/bin/bash', 11:16:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:30 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:30 INFO - 'USER': 'cltbld', 11:16:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:30 INFO - 'XPC_FLAGS': '0x0', 11:16:30 INFO - 'XPC_SERVICE_NAME': '0', 11:16:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:16:30 INFO - Cleaning up... 11:16:30 INFO - Return code: 0 11:16:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10386d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80fac647e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:31 INFO - 'HOME': '/Users/cltbld', 11:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:31 INFO - 'LOGNAME': 'cltbld', 11:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:31 INFO - 'MOZ_NO_REMOTE': '1', 11:16:31 INFO - 'NO_EM_RESTART': '1', 11:16:31 INFO - 'PAGER': '/bin/cat', 11:16:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:31 INFO - 'PWD': '/builds/slave/test', 11:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:31 INFO - 'SHELL': '/bin/bash', 11:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:31 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:31 INFO - 'USER': 'cltbld', 11:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:31 INFO - 'XPC_FLAGS': '0x0', 11:16:31 INFO - 'XPC_SERVICE_NAME': '0', 11:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:16:31 INFO - Cleaning up... 11:16:31 INFO - Return code: 0 11:16:31 INFO - Running post-action listener: _resource_record_post_action 11:16:31 INFO - Running post-action listener: _start_resource_monitoring 11:16:31 INFO - Starting resource monitoring. 11:16:31 INFO - [mozharness: 2017-02-17 19:16:31.438932Z] Finished create-virtualenv step (success) 11:16:31 INFO - [mozharness: 2017-02-17 19:16:31.439915Z] Running install step. 11:16:31 INFO - Running pre-action listener: _resource_record_pre_action 11:16:31 INFO - Running main action method: install 11:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:31 INFO - Reading from file tmpfile_stdout 11:16:31 INFO - Detecting whether we're running mozinstall >=1.0... 11:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:16:31 INFO - Reading from file tmpfile_stdout 11:16:31 INFO - Output received: 11:16:31 INFO - Usage: mozinstall [options] installer 11:16:31 INFO - Options: 11:16:31 INFO - -h, --help show this help message and exit 11:16:31 INFO - -d DEST, --destination=DEST 11:16:31 INFO - Directory to install application into. [default: 11:16:31 INFO - "/builds/slave/test"] 11:16:31 INFO - --app=APP Application being installed. [default: firefox] 11:16:31 INFO - mkdir: /builds/slave/test/build/application 11:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:16:53 INFO - Reading from file tmpfile_stdout 11:16:53 INFO - Output received: 11:16:53 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:16:53 INFO - Running post-action listener: _resource_record_post_action 11:16:53 INFO - [mozharness: 2017-02-17 19:16:53.148371Z] Finished install step (success) 11:16:53 INFO - [mozharness: 2017-02-17 19:16:53.148510Z] Running run-tests step. 11:16:53 INFO - Running pre-action listener: _resource_record_pre_action 11:16:53 INFO - Running main action method: run_tests 11:16:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:16:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:16:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:16:53 INFO - 2017-02-17 11:16:53.163 screenresolution[1625:7291] starting screenresolution argv=screenresolution get 11:16:53 INFO - 2017-02-17 11:16:53.166 screenresolution[1625:7291] Display 0: 1600x1200x32@60 11:16:53 INFO - 2017-02-17 11:16:53.172 screenresolution[1626:7294] starting screenresolution argv=screenresolution list 11:16:53 INFO - Available Modes on Display 0 11:16:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:16:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:16:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:16:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:16:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:16:53 INFO - Intel Iris: 11:16:53 INFO - Chipset Model: Intel Iris 11:16:53 INFO - Type: GPU 11:16:53 INFO - Bus: Built-In 11:16:53 INFO - VRAM (Dynamic, Max): 1536 MB 11:16:53 INFO - Vendor: Intel (0x8086) 11:16:53 INFO - Device ID: 0x0a2e 11:16:53 INFO - Revision ID: 0x0009 11:16:53 INFO - Displays: 11:16:53 INFO - Display: 11:16:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:16:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:16:53 INFO - Display Serial Number: 1600x1200 60 11:16:53 INFO - Main Display: Yes 11:16:53 INFO - Mirror: Off 11:16:53 INFO - Online: Yes 11:16:53 INFO - Rotation: Supported 11:16:53 INFO - Return code: 0 11:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:16:53 INFO - Python 2.7.3 11:16:53 INFO - Return code: 0 11:16:53 INFO - grabbing minidump binary from tooltool 11:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10370bd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103571db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103703b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:16:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:16:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:16:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:16:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:53 INFO - Return code: 0 11:16:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:16:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:16:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:16:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:16:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0091 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:16:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lMxpRE7g1M/Render', 11:16:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:53 INFO - 'HOME': '/Users/cltbld', 11:16:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:53 INFO - 'LOGNAME': 'cltbld', 11:16:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:53 INFO - 'MOZ_NO_REMOTE': '1', 11:16:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:53 INFO - 'NO_EM_RESTART': '1', 11:16:53 INFO - 'PAGER': '/bin/cat', 11:16:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:53 INFO - 'PWD': '/builds/slave/test', 11:16:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:53 INFO - 'SHELL': '/bin/bash', 11:16:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners', 11:16:53 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 11:16:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:53 INFO - 'USER': 'cltbld', 11:16:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:53 INFO - 'XPC_FLAGS': '0x0', 11:16:53 INFO - 'XPC_SERVICE_NAME': '0', 11:16:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:16:53 INFO - mozversion application_buildid: 20170217083319 11:16:53 INFO - mozversion application_changeset: dd50cacb9a992168c4d78e049f06eb098aee6f58 11:16:53 INFO - mozversion application_display_name: Firefox 11:16:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:53 INFO - mozversion application_name: Firefox 11:16:53 INFO - mozversion application_remotingname: firefox 11:16:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:16:53 INFO - mozversion application_vendor: Mozilla 11:16:53 INFO - mozversion application_version: 52.0 11:16:53 INFO - mozversion platform_buildid: 20170217083319 11:16:53 INFO - mozversion platform_changeset: dd50cacb9a992168c4d78e049f06eb098aee6f58 11:16:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:16:53 INFO - mozversion platform_version: 52.0 11:16:53 INFO - using testdate: 1487359013 11:16:53 INFO - actual date: 1487359013 11:16:53 INFO - starting webserver on 'localhost:49235' 11:16:53 INFO - SUITE-START | Running 2 tests 11:16:53 INFO - TEST-START | dromaeo_css 11:16:53 INFO - operating with platform_type : mac_ 11:16:53 INFO - Initialising browser for dromaeo_css test... 11:16:53 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmpQ4CZ0v/profile http://localhost:49235/getInfo.html) 11:16:56 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 11:16:56 INFO - PROCESS | 1636 | colorDepth:24 11:16:56 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 11:16:56 INFO - PROCESS | 1636 | __metrics 11:16:56 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:16:56 INFO - PROCESS | 1636 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:57 INFO - TEST-INFO | 1636: exit 0 11:16:57 INFO - Browser initialized. 11:16:57 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:57 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmpQ4CZ0v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:09 INFO - PROCESS | 1639 | RSS: Main: 172113920 11:17:09 INFO - PROCESS | 1639 | 11:20:12 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 11:20:14 INFO - PROCESS | 1639 | RSS: Main: 311271424 11:20:14 INFO - PROCESS | 1639 | 11:23:17 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 11:23:17 INFO - PROCESS | 1639 | RSS: Main: 306237440 11:23:17 INFO - PROCESS | 1639 | 11:26:20 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 11:26:20 INFO - PROCESS | 1639 | RSS: Main: 271077376 11:26:20 INFO - PROCESS | 1639 | 11:29:23 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 11:29:23 INFO - PROCESS | 1639 | RSS: Main: 275939328 11:29:23 INFO - PROCESS | 1639 | 11:32:27 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 11:32:27 INFO - PROCESS | 1639 | RSS: Main: 257597440 11:32:27 INFO - PROCESS | 1639 | 11:35:30 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 11:35:30 INFO - PROCESS | 1639 | RSS: Main: 324476928 11:35:30 INFO - PROCESS | 1639 | 11:35:30 INFO - PROCESS | 1639 | __start_tp_report 11:35:30 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 11:35:30 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 11:35:30 INFO - PROCESS | 1639 | |i|pagename|runs| 11:35:30 INFO - PROCESS | 1639 | |0;dojo.html;3043.923901902452;3445.5004024416476;3445.9827700861492;3458.3429148461773;3509.666581674742;5624.184493248482;5680.460356266148;5699.145128230763;5714.799982000631;5728.3126024876965;4736.360591320171;5490.780368785244;5644.520215781653;5742.79900203493;5763.5101016413655;4838.298446725223;5150.098732721777;5169.767360468788;5190.558802501791;5217.947820521803;5124.949385375989;5137.357830271216;5148.124818780798;5233.555147812441;5302.893942121155;4307.698461107724;5117.976404719053;5171.482851714836;5182.766775495112;5183.118869792144;5152.819651312205;5211.5049070338255;5240.371155461331;5244.108501554745;5285.577153827685;5118.334616499831;5198.064348417283;5203.16749320107;5204.687718736888;5215.817446389358;5181.3782346118705;5209.2446595243855;5582.078956972095;5600.327960644708;5611.102223644198;6149.692515374258;6196.907046394308;6222.315545290015;6233.34549872266;6240.875182496325;6298.622082675054;6327.8418039548915;6331.620102793801;6337.207849018872;6338.651374174418;5673.149027645886;5727.627704199297;5735.283089613798;5842.824715258549;5884;6264.214698810817;6272.780452684134;6286.214223222098;6292.150559674477;6296.590721603173;6155.2921414037955;6162.753489860445;6175.752969881154;6187.319394866561;6192.938070619236;6110.26676798787;6114.480269177081;6164.722587483574;6277.654728989858;6297.4962003039645;6126.9495973575995;6140.565599444524;6141.771645670884;6144.9553575892205;6169.81490555284;6158.291796443376;6197.442230199304;6240.594361366497;6260.248770147611;6265.530085243625;4962.975185124052;4974.701517908937;4979.502049795064;4988.825391111293;4997.825076122318;4407.669424793154;4425.601695847325;4467.061916997402;4477.216487114807;4517.051419201939;5679.6876171810945;5719.027765279912;5747.655140691572;5748.540116790647;5821.18503409523;6187.783427580013;6228.875422491525;6258.718357673915;6283.654399008098;6286.465650419674;5720.056190728483;5750.6262092963825;5763.308402991668;5773.451522105393;5776.104703770922;5343.946560534345;5369.731513424314;5376.623636345496;5383.596230282745;5402.864928376822;6253.874922501615;6274.152989346379;6276.811695649138;6278.152449419453;6283.465905398092;5808.5353171747;6083.543734219863;6266.624002559861;6272.372762723691;6292.276388215414;4995.375578052744;6172.814815555541;6174.289956654862;6233.532485063548;6253.218347706536;6085.66528840918;6123.008104567321;6163.753449861955;6165.260168779775;6198.907016394667;6216;6220.906686399798;6222.222222222223;6231.875362492816;6234.563580549499;5006.574441172541;5969;6029.547783916311;6081.39186081406;6111.113888486056;6066.848328791815;6092.908606370819;6117.005394430456;6172.475339596184;6180.47465965398;5962.850928726816;5988.341282458839;6008.54935879802;6013.819585412444;6032.426919442646;5896.262967129109;6116.785912493041;6143.84640383994;6146.723397447215;6154.415330543591;5861.9706901465215;5869.618474799125;5888.352281249145;5925.111233315038;5972.193753843349 11:35:30 INFO - PROCESS | 1639 | |1;ext.html;479.2954357095071;489.5178249424316;490.92145256758903;535.7696190638027;549.4340828946187;30770.230744231376;32791.34417311655;39363.80318098409;40281.395779063336;40652.39021414681;41157;42277;42503.78748106263;42604.57395426045;42669.35995960055;9382.859257111131;9505.334626576143;9510.429374237568;9516.143547080761;9533.904660953405;8670.176333248332;8886.822263554724;11308.943455282712;11520;11554.364509951949;11428.314301141916;11500.367479788609;11509.827352589718;11522.942385288063;11539.134564907623;11318.151138664633;11352.772944541062;11387.829182562185;11390.658280251648;11395.715107122305;11396.145289103268;11470.139739519485;11475.827862582068;11479.196456248066;11480.253783504046;39336.60663393358;39573;39621;39742.80128599339;39852.800735996425;3402.6937575618067;3483.3555792178277;3597.6402359764074;3765.7363984521094;3942.8225729842225;28411;29286.707132928612;29724;30844.691553084405;31867.725290988332;3132.530120481923;3174.0477856643147;3239.4492936200904;3312.5362449257123;3352.312775880963;364831.1758441217;365749;366347;367341;473770.63114684896;58181;58337.4166258332;58348.70825645845;58401.123983140285;58584.12123818146;60358;60360;60387.39612603818;60462.39537604568;60500;16128.354865805471;16411;16411.83588164127;16416.589585260463;16434.83565164357;11719.941400293115;11953.103517236243;12779.872201277869;12889.097763156677;12889.548865789653;14173.574792756233;14264.714705705828;14265.928670356581;14299.64250893736;15136.318865651072;5445.482679145475;6168.691565421801;6465.988858634596;6485.967570162214;6564.245111812107;852.3309202276183;969.1471505075489;989.5893204320271;1007.9143272821746;1062.4103622489592;27682.508574228417;28590.857045715053;28634.427311453655;29372.853135734185;29468.11595652134;865.4634126841398;899.6851102114339;1041.6042503045956;1051.5791096895516;1104.9779004419865;14987.925060374628;15073.095614263179;15135.924320378328;15341.923290383476;15456.381744730084;629294;633129;636505;636524;659704;45641;55443.89112217733;56487;56680;59891;1364.2973868457752;1371.7942308653583;1419.176877411099;1422.2035660030417;1426.1656930695451;25966.48067038611;29345.266368340108;30179.09462716122;30219.546706799854;30643.2339191522;39153.608463916134;48599.54201373964;48628.541143765746;48711.26933096077;48732.51267487422;539009;541433;541639;542656;543496;37716.43425348567;37966.620333797415;38498.6150138495;38609;38685;44725.776371117936;45219.09561808811;45578.77210613926;46325.536744632125;46602.300965484865;37146.8142659285;37223;37341.81329093337;37468.81265593655;38752.41871371988;37009.81495092507;37462.8126859364;38427.42358864675;38438.039049023995;38498.80750596229;36456.63543364532;36905.63094369022;37588.436173457965;37983;38441.231175376895;31933.680663194;33971.83014084914;33974.660253398135;34014.48978265279;34062.829685851415;24590;24744.381390465383;24945.875270623532;25110;25652.102176424483 11:35:30 INFO - PROCESS | 1639 | |2;jquery.html;365.0927445298431;385.09502668728476;388.9222155568886;397.6878150651738;411.96086371794667;15287.464938727147;15498.457553985612;18425.907870460647;20332.08505617247;20841.749495030308;18956.905215473937;19602.901985490054;20057.799422005777;20187.899060504715;20199.38404927602;5703.828885133442;5795.15970184323;5827.300723913137;5828.883422331572;5973.22348094747;5936.198613187207;6148.508119350441;6153.476954458876;6164.907526387108;6172.043333283348;5689.829305120853;6020.608660437079;6056.212692349988;6107.4808641265545;6113.868934247179;5995.280566332046;6025.427584379477;6032.276126864783;6074.787382441637;6584.242812076624;5890.057590785454;5891.499222566087;5895.64626122434;5895.675737834417;5898.675572843492;13165.210087394787;15683;20362.490937726674;25124.874375628187;25357.74642253572;2205.669149627569;2359.64605309205;2494.301595553248;2649.5098406794614;2972.806767560102;8056.436049476539;9864.408135511892;9868.506574671237;9939.453330066843;10398.376097434179;1801.3425099838464;1826.2877477783543;1854.5919897622503;1876.0807204469847;1932.468571142947;99675;113823.43088284589;115178.42410787892;115474.42262788716;115534.99999999916;11580.189386743015;11612.76774464506;11746.17776755636;11762.235454695418;11895.334653148566;15017.549473515812;15034.473793417177;15035.774463383059;15042.699146017017;15055.698886022219;7448.590327532038;7987.881696562486;8579.613917373608;8586.742397728078;8743.825123497494;8448.239658430648;8454.026092428474;8477.745667629857;8623.137686231326;8639.568021598894;4572.8399506017795;4580.328180214265;4609.677322587387;4613.192691279013;4657.115148121914;1457.5044484875193;1862.835727670206;1871.8970456625016;1928.305809908432;1931.33368987699;888.5424006636588;894.3158483759929;915.2220612479339;949.8100379924043;1007.6876168387823;18721.31508164272;19759.40721778349;20276.79723202749;21364.359069227947;21837.45406364822;907.9137481939205;933.8319102561468;945.0879900895532;949.8717673114041;985.7535616095976;11047.558097676163;11310.377929213808;11328.546858125583;11350.48922798476;11359.488823002985;598779;603062.9846850826;612434;616172;617138;134061;134647;135086;135900;137013;936.0826390137703;968.6997030920437;994.1947022911465;997.0378584665832;997.6209040564684;16558.503244902673;18156.092195390444;19721.506962326057;19722.704159437333;19723.704144438132;42950;52843.47156528386;53731.462685372644;55595.44404555903;57076.71461642831;75567.62216188884;77729.61135194288;79850.41421064989;79963.60018199871;83580;10911.727206819893;11911.404429778304;12084.879151208375;12260.892600978772;12333.50665973351;12249.571265005681;12666.240025598494;13447.596572102853;13484.932575337061;13956.302184890917;5642.23829782974;11272.210945233755;11485.655430337103;11915.344656044;11953.880461195276;8056.395770317133;9467.857982130135;11592.768144637228;11934.52261909514;12115.515379384726;7939.444238903221;8119.634616442392;8156;8160.020797504338;8226.794330141794;11865.762684746429;12429.813552796897;12724.554640587536;12735.108542401942;12789.296588687712;11529.884701153216;11557.88442115568;11599.304041757521;12077.456514457046;12085.637430877088 11:35:30 INFO - PROCESS | 1639 | |3;mootools.html;1346.9259190744506;1485.1905711387296;1507.1409296700879;1687.232309299269;1861.5160058384815;7427.183009868917;7821.10057343405;8039.959800201005;8247.134050924642;8265.462744921591;8138.715144969928;8254.504729716222;8258.009038915323;8258.958705206465;8259.050209225941;2253.740819805723;2294.9311520654323;2295.850769699964;2296.7932886040253;2298.367948814073;2282.167009041696;2316.733575638798;2347.3427440316736;2347.4366152123453;2350.9059637614473;2322.7328857181387;2334.0663734506247;2354.176038386568;2358.882055897207;2365.0303375616;2317.1774020222747;2321.7446080931086;2329.5340931813703;2350.4123969007833;2351.729551101628;2335.556244313592;2361.1971929543865;2364.645303204516;2366.6095094309417;2368.2539999899977;8109.107998120202;8268.83462330756;8299.751007469786;8309.8338033239;8318.916810831935;5017.397912250517;5211.218317252405;5213.3743950725775;5260.815871444519;5267.86830329241;3248.2297148054367;3508.3509550733197;3570.589382221052;3575.6781889630056;3576.409892367756;1045.2004216774174;1069.6630561373142;1101.2181351240629;1112.0825319111766;1116.1573012375604;10824.512896919658;10844.2951208172;10939.124870010459;10960.01359877607;10961.780764384668;3825.6939444844347;4254.957450425456;4411.7867586413995;4442.711223770445;4493.213687604656;7816.843663126706;8674.826503469896;8679.652813887375;8703.521306328086;8707.825843483095;5014.52362025607;5106.208537676666;5107;5111.437741848394;5112.616553758483;4109.486314210723;4323.783810809447;4443.755593442392;4465.955340446554;4802.73584952831;3654.3239500692457;3706.388445906395;3783.697304215656;3792.8482860685262;3794.79128647927;1107.5071593141136;1108.545496346494;1108.6729414822646;1108.8503052088026;1115.8605174353206;770.3413581387945;795.9930687679973;840.6469282901196;884.6726711116928;912.412402419798;5355;5607.859803504945;5634.690092044977;5738;5905.822825315247;438.68195558220674;459.08412716630534;466.4379422795523;468.39810843067175;472.4613940108279;3785.6025117362833;3839.865604703822;3927.430522574268;3930;3949.861754838567;9768.316217864682;10042.74893127663;10125.493725313705;10129.240306977006;10144.695659130239;9544.809103818023;9782.657606983863;10057.748556286151;10085.899141008642;10225.897741022494;7710.036245469317;7778.49439786412;7781.377489800802;7900.920990790133;7914.802129946682;5733.111367738007;5749.13762935563;5796.9420305798085;5819.359870414166;5930.28836539618;8987.685431009882;9247.537623118682;9337;9362.876454825464;9373.812523749622;7905.881411778713;8787.121287871161;9063.184313411824;9654.517274136406;9660.130588247092;5696.401877802771;7104.147502299757;7151.141862976476;7247.2390399009455;7262.527935684164;7674.8081297968;7887.014123234596;7972.84054318922;8096.392770542115;8097.2712455879255;7155.248698886542;7206.495545311987;7250.746223882139;7252.818679532843;7377.151627562899;6936.895946560907;6947.75682851118;6962.094927659372;6991.2309645937885;7009.053777740144;6668.29982851813;6722.932770672231;6735.865282694221;6756.662166891734;6767.593944363354;4795.9280610790165;4831.299461578122;4838.588719958843;4901.215805471107;4943.5797957174045;4789.9042019160115;4793.952060479351;4815.181419158822;4979.327790748347;5126.4617215191865 11:35:30 INFO - PROCESS | 1639 | |4;prototype.html;278.7700147378413;308.1464343767763;315.87522928443263;320.845993922917;322.64509040055924;4622.399088118544;4759.738214398211;4934.28452874333;4987.002599480109;5225.529702326795;4017.4375587417785;4325.480942286922;5052.823151189709;5085.135526960416;5085.694858308504;3570.2680950405233;3899.3038028457568;3961.6038396160443;3994.641821780594;4015.927815221358;3191.952120718191;3957.9208415831667;3994.101327201371;3997.2405243003736;4004.7797371144575;3217.7747557670973;3661.3775658138047;3914.7846868422225;3969.30537155998;4031.97984010081;3430.451127819562;3967.1272320089533;3968.40473928913;3985.2826491231567;4003.4795476588147;3469.340825243221;3486.808225547594;3487.9128021799406;3491.6857482826667;3512.8243587820507;4770.015333976004;4955.36472963921;5012.195609580548;5012.774425150877;5013.072581572421;4480.244649540509;4481.305397663367;4481.820727170909;4514.345419914127;4525.343825145368;4886.633502487292;5273.578113750929;5339.813106541253;5363.383210930754;5398.946010539884;3076;3227.7579181561478;3798.4236541835107;3802.524684414448;3842.4620553122586;5459.727013649302;5527.364353099365;5585.776568937278;5605.103183490622;5611.2144299798065;3601.3517566837695;3612.9277414451562;3856.8842934712;3878.6897048236074;3896.5713771485116;3785.2240290740883;3927.6842257843373;3946.2699400610977;3948.4669569607736;3949.3483575210344;4315.532718875597;4444.511103778582;4486.461624605068;4502.482214545369;4545.977155140133;5045;5093.719845408538;5352.357717073976;5356.330458692663;5386.730663466889;1107.4495706011649;1175.3594291111365;1212.5574165429555;1243.6952946528158;1254.9121561490608;777.8794286885542;822.658596682382;860.2773670117132;870.0994470722771;892.1435421994828;3974.463447434617;4005.9799701001893;4087.7138600297694;4501.279795232747;4544.6818722689095;4209.768462734579;4306.0526684129445;4563.956827705338;5230.34620672416;5244.9737751310995;3841.2893614681375;4213.936790948138;4285.571442855752;4562.1560011398;4711.952880471152;2763.69599344072;2776.237643544686;2780.124260857823;2783.4711404833015;2805.2145399288233;4463.732176069446;5428.348598168245;5444.346678398618;5467.152591348347;5524.889502209933;4868.075065737569;5040.445550989388;5331.920021199685;5401.918971215435;5406.810761623325;4193.517745459311;4394.670399720034;5051.4443411224;5235.110031294689;5459.334902854667;4195.433616461861;4500.887477813081;5126.154184559506;5228.921566176587;5282.524572788468;4037.6164264394833;5518.06192947208;5595.964746521907;5615;5630.943690563042;5413.56691464674;5760.596758226884;5874.03078492044;5878.882422351615;5886;3675.4303083022173;3930.803459827054;3966.2464131814863;3998.6401223888824;3998.900027499336;4512.481064677473;4532.954670453385;5547.528460080777;5581.413951535031;5625.746841392229;4351.477822661174;4788.473267940454;5473.397926228191;5478.479544443271;5518.558515318845;5142.460041695717;5428;5455.399906010415;5458.344998600193;5465.234867118686;4602.953970460252;5036.147347279408;5289.788408463773;5377.542908852792;5378.354597448175;5209.47905209476;5233.084210263265;5351.625386222927;5465.6447330923365;5469.480399362054;4851.563359297539;5344.5991550634635;5352;5387.973060134675;5391.838244852661 11:35:30 INFO - PROCESS | 1639 | |5;yui.html;605.5791225098557;724.5399171526079;782.9821232397882;783.8745800671886;795.4431897671632;14239.288035598218;14634.707305853877;15200.923995380008;15243.085414875115;15446.61383465414;13553.254570998615;13930.373133209005;14025.719485610281;14028.509002184926;14079.366428510715;838.6980686952692;858.8325276571071;859.6346552715103;860.8063185783211;863.6933888469597;692.4737199728193;715.1096884378956;841.4026041510535;867.6876324523198;869.0180096490988;918.660095764568;918.678462538113;920.2499962530517;922.9815403691922;923.2383283790866;909.8316811389914;911.1662828511903;913.1963871792813;913.9497327646977;914;678.5894533807025;678.7963610916754;679.3342524326188;680.3366717450496;681.8534015186709;13677.24775137377;14013.929930350385;14047.78928316076;14068.366923488366;14659.34032968519;14079.929600352036;14309.713805723828;14323.665707893913;14418.49535266271;14647.529759822568;10174.643887463977;10378.827192527235;10536.894631053668;10654.4140072296;10939.070179034792;4398.560143985608;4436.401085853433;4511.954880451186;4534.36518887356;4684.464451632456;86884.56557717171;88606;88815;89092;90970.99999999935;10409.063184313449;10620.468976551141;10655.84016239757;10681.786364272672;10762.838557421645;19618;19635;19699.212031518866;20027.59944801125;20036;7139;7189.571783645376;7203.531770434905;7363.410927125817;7365.521241119417;4179.28316663758;4231.174920890458;4298.989737411705;4379.211741886491;4418.7127836690515;3186.729128024144;3293.4730443128983;3294.40700673881;3296.6703329666843;3298.5546951161764;567.2115759094861;567.2512283785446;568.8634727665413;584.7310237290809;590.3594599859115;486.93669822922794;563.811123273708;575.4648177195165;585.2479563760547;594.8275000249965;7282.417406607458;8728.825423491622;8780.297576193889;8922.063183365783;9055.95472022649;571.1603942204952;597.6862147372664;603.7766026570109;613.2916481463916;622.9159063526456;4155.750654960712;4226.1758957003085;4232.555581663943;4291.154217083054;4313.61177494027;93120.53439732757;94499.52750236342;97668;98025.03949920961;100009.99990000152;94139;98497;101322.98677013283;101559;103969;85551.5722421384;85588.57205714055;86830.99999999873;88208;90351.54824225837;8174.019117705676;8294.170582941657;8342.249197572248;8345.082040975609;8475.788105297417;53931;56067;56073;56630.43369566252;58931.81215972261;61873;63118.47526098905;64506.67746661237;69915;81294.78057829019;12604.55884044054;12635.684107897376;12643.747125057631;13205.405756740778;13447.865521344662;11044.613438529614;14217.360218789972;14264.714705706036;14347.497837575635;15337.539873803804;13099.476020959437;13120;13437.260950647807;13542.322883855964;14147.787783183467;13090.541831035867;13203.801942971055;13270.668233294246;13678.794818077538;14000.159990400609;12685.873141268468;12824.871751282368;13023.739525209254;13174.187403262613;13931.233782142079;11045;11312.434378281218;11317.264377815416;11414.429278536207;11870.406479675808;10788.838167427652;11196.600424946882;11392.15295757837;11482.311061336346;11544.538218471167 11:35:30 INFO - PROCESS | 1639 | __end_tp_report 11:35:30 INFO - PROCESS | 1639 | __start_cc_report 11:35:30 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1588 11:35:30 INFO - PROCESS | 1639 | __end_cc_report 11:35:30 INFO - PROCESS | 1639 | __startTimestamp1487360130861__endTimestamp 11:35:30 INFO - PROCESS | 1639 | 11:35:30 INFO - PROCESS | 1639 | ------- Summary: start ------- 11:35:30 INFO - PROCESS | 1639 | Number of tests: 6 11:35:30 INFO - PROCESS | 1639 | 11:35:30 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5706.12 Median:5925.11 stddev:650.97 (11.0%) stddev-sans-first:618.55 11:35:30 INFO - PROCESS | 1639 | Values: 3043.9 3445.5 3446.0 3458.3 3509.7 5624.2 5680.5 5699.1 5714.8 5728.3 4736.4 5490.8 5644.5 5742.8 5763.5 4838.3 5150.1 5169.8 5190.6 5217.9 5124.9 5137.4 5148.1 5233.6 5302.9 4307.7 5118.0 5171.5 5182.8 5183.1 5152.8 5211.5 5240.4 5244.1 5285.6 5118.3 5198.1 5203.2 5204.7 5215.8 5181.4 5209.2 5582.1 5600.3 5611.1 6149.7 6196.9 6222.3 6233.3 6240.9 6298.6 6327.8 6331.6 6337.2 6338.7 5673.1 5727.6 5735.3 5842.8 5884.0 6264.2 6272.8 6286.2 6292.2 6296.6 6155.3 6162.8 6175.8 6187.3 6192.9 6110.3 6114.5 6164.7 6277.7 6297.5 6126.9 6140.6 6141.8 6145.0 6169.8 6158.3 6197.4 6240.6 6260.2 6265.5 4963.0 4974.7 4979.5 4988.8 4997.8 4407.7 4425.6 4467.1 4477.2 4517.1 5679.7 5719.0 5747.7 5748.5 5821.2 6187.8 6228.9 6258.7 6283.7 6286.5 5720.1 5750.6 5763.3 5773.5 5776.1 5343.9 5369.7 5376.6 5383.6 5402.9 6253.9 6274.2 6276.8 6278.2 6283.5 5808.5 6083.5 6266.6 6272.4 6292.3 4995.4 6172.8 6174.3 6233.5 6253.2 6085.7 6123.0 6163.8 6165.3 6198.9 6216.0 6220.9 6222.2 6231.9 6234.6 5006.6 5969.0 6029.5 6081.4 6111.1 6066.8 6092.9 6117.0 6172.5 6180.5 5962.9 5988.3 6008.5 6013.8 6032.4 5896.3 6116.8 6143.8 6146.7 6154.4 5862.0 5869.6 5888.4 5925.1 5972.2 11:35:30 INFO - PROCESS | 1639 | 11:35:30 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:66127.52 Median:37184.91 stddev:142525.58 (383.3%) stddev-sans-first:142840.18 11:35:30 INFO - PROCESS | 1639 | Values: 479.3 489.5 490.9 535.8 549.4 30770.2 32791.3 39363.8 40281.4 40652.4 41157.0 42277.0 42503.8 42604.6 42669.4 9382.9 9505.3 9510.4 9516.1 9533.9 8670.2 8886.8 11308.9 11520.0 11554.4 11428.3 11500.4 11509.8 11522.9 11539.1 11318.2 11352.8 11387.8 11390.7 11395.7 11396.1 11470.1 11475.8 11479.2 11480.3 39336.6 39573.0 39621.0 39742.8 39852.8 3402.7 3483.4 3597.6 3765.7 3942.8 28411.0 29286.7 29724.0 30844.7 31867.7 3132.5 3174.0 3239.4 3312.5 3352.3 364831.2 365749.0 366347.0 367341.0 473770.6 58181.0 58337.4 58348.7 58401.1 58584.1 60358.0 60360.0 60387.4 60462.4 60500.0 16128.4 16411.0 16411.8 16416.6 16434.8 11719.9 11953.1 12779.9 12889.1 12889.5 14173.6 14264.7 14265.9 14299.6 15136.3 5445.5 6168.7 6466.0 6486.0 6564.2 852.3 969.1 989.6 1007.9 1062.4 27682.5 28590.9 28634.4 29372.9 29468.1 865.5 899.7 1041.6 1051.6 1105.0 14987.9 15073.1 15135.9 15341.9 15456.4 629294.0 633129.0 636505.0 636524.0 659704.0 45641.0 55443.9 56487.0 56680.0 59891.0 1364.3 1371.8 1419.2 1422.2 1426.2 25966.5 29345.3 30179.1 30219.5 30643.2 39153.6 48599.5 48628.5 48711.3 48732.5 539009.0 541433.0 541639.0 542656.0 543496.0 37716.4 37966.6 38498.6 38609.0 38685.0 44725.8 45219.1 45578.8 46325.5 46602.3 37146.8 37223.0 37341.8 37468.8 38752.4 37009.8 37462.8 38427.4 38438.0 38498.8 36456.6 36905.6 37588.4 37983.0 38441.2 31933.7 33971.8 33974.7 34014.5 34062.8 24590.0 24744.4 24945.9 25110.0 25652.1 11:35:30 INFO - PROCESS | 1639 | 11:35:30 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:35349.90 Median:14003.63 stddev:101704.54 (726.3%) stddev-sans-first:101955.92 11:35:30 INFO - PROCESS | 1639 | Values: 365.1 385.1 388.9 397.7 412.0 15287.5 15498.5 18425.9 20332.1 20841.7 18956.9 19602.9 20057.8 20187.9 20199.4 5703.8 5795.2 5827.3 5828.9 5973.2 5936.2 6148.5 6153.5 6164.9 6172.0 5689.8 6020.6 6056.2 6107.5 6113.9 5995.3 6025.4 6032.3 6074.8 6584.2 5890.1 5891.5 5895.6 5895.7 5898.7 13165.2 15683.0 20362.5 25124.9 25357.7 2205.7 2359.6 2494.3 2649.5 2972.8 8056.4 9864.4 9868.5 9939.5 10398.4 1801.3 1826.3 1854.6 1876.1 1932.5 99675.0 113823.4 115178.4 115474.4 115535.0 11580.2 11612.8 11746.2 11762.2 11895.3 15017.5 15034.5 15035.8 15042.7 15055.7 7448.6 7987.9 8579.6 8586.7 8743.8 8448.2 8454.0 8477.7 8623.1 8639.6 4572.8 4580.3 4609.7 4613.2 4657.1 1457.5 1862.8 1871.9 1928.3 1931.3 888.5 894.3 915.2 949.8 1007.7 18721.3 19759.4 20276.8 21364.4 21837.5 907.9 933.8 945.1 949.9 985.8 11047.6 11310.4 11328.5 11350.5 11359.5 598779.0 603063.0 612434.0 616172.0 617138.0 134061.0 134647.0 135086.0 135900.0 137013.0 936.1 968.7 994.2 997.0 997.6 16558.5 18156.1 19721.5 19722.7 19723.7 42950.0 52843.5 53731.5 55595.4 57076.7 75567.6 77729.6 79850.4 79963.6 83580.0 10911.7 11911.4 12084.9 12260.9 12333.5 12249.6 12666.2 13447.6 13484.9 13956.3 5642.2 11272.2 11485.7 11915.3 11953.9 8056.4 9467.9 11592.8 11934.5 12115.5 7939.4 8119.6 8156.0 8160.0 8226.8 11865.8 12429.8 12724.6 12735.1 12789.3 11529.9 11557.9 11599.3 12077.5 12085.6 11:35:30 INFO - PROCESS | 1639 | 11:35:30 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5383.86 Median:4996.93 stddev:2952.67 (59.1%) stddev-sans-first:2945.37 11:35:30 INFO - PROCESS | 1639 | Values: 1346.9 1485.2 1507.1 1687.2 1861.5 7427.2 7821.1 8040.0 8247.1 8265.5 8138.7 8254.5 8258.0 8259.0 8259.1 2253.7 2294.9 2295.9 2296.8 2298.4 2282.2 2316.7 2347.3 2347.4 2350.9 2322.7 2334.1 2354.2 2358.9 2365.0 2317.2 2321.7 2329.5 2350.4 2351.7 2335.6 2361.2 2364.6 2366.6 2368.3 8109.1 8268.8 8299.8 8309.8 8318.9 5017.4 5211.2 5213.4 5260.8 5267.9 3248.2 3508.4 3570.6 3575.7 3576.4 1045.2 1069.7 1101.2 1112.1 1116.2 10824.5 10844.3 10939.1 10960.0 10961.8 3825.7 4255.0 4411.8 4442.7 4493.2 7816.8 8674.8 8679.7 8703.5 8707.8 5014.5 5106.2 5107.0 5111.4 5112.6 4109.5 4323.8 4443.8 4466.0 4802.7 3654.3 3706.4 3783.7 3792.8 3794.8 1107.5 1108.5 1108.7 1108.9 1115.9 770.3 796.0 840.6 884.7 912.4 5355.0 5607.9 5634.7 5738.0 5905.8 438.7 459.1 466.4 468.4 472.5 3785.6 3839.9 3927.4 3930.0 3949.9 9768.3 10042.7 10125.5 10129.2 10144.7 9544.8 9782.7 10057.7 10085.9 10225.9 7710.0 7778.5 7781.4 7900.9 7914.8 5733.1 5749.1 5796.9 5819.4 5930.3 8987.7 9247.5 9337.0 9362.9 9373.8 7905.9 8787.1 9063.2 9654.5 9660.1 5696.4 7104.1 7151.1 7247.2 7262.5 7674.8 7887.0 7972.8 8096.4 8097.3 7155.2 7206.5 7250.7 7252.8 7377.2 6936.9 6947.8 6962.1 6991.2 7009.1 6668.3 6722.9 6735.9 6756.7 6767.6 4795.9 4831.3 4838.6 4901.2 4943.6 4789.9 4794.0 4815.2 4979.3 5126.5 11:35:30 INFO - PROCESS | 1639 | 11:35:30 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4295.24 Median:4554.07 stddev:1301.89 (28.6%) stddev-sans-first:1270.16 11:35:30 INFO - PROCESS | 1639 | Values: 278.8 308.1 315.9 320.8 322.6 4622.4 4759.7 4934.3 4987.0 5225.5 4017.4 4325.5 5052.8 5085.1 5085.7 3570.3 3899.3 3961.6 3994.6 4015.9 3192.0 3957.9 3994.1 3997.2 4004.8 3217.8 3661.4 3914.8 3969.3 4032.0 3430.5 3967.1 3968.4 3985.3 4003.5 3469.3 3486.8 3487.9 3491.7 3512.8 4770.0 4955.4 5012.2 5012.8 5013.1 4480.2 4481.3 4481.8 4514.3 4525.3 4886.6 5273.6 5339.8 5363.4 5398.9 3076.0 3227.8 3798.4 3802.5 3842.5 5459.7 5527.4 5585.8 5605.1 5611.2 3601.4 3612.9 3856.9 3878.7 3896.6 3785.2 3927.7 3946.3 3948.5 3949.3 4315.5 4444.5 4486.5 4502.5 4546.0 5045.0 5093.7 5352.4 5356.3 5386.7 1107.4 1175.4 1212.6 1243.7 1254.9 777.9 822.7 860.3 870.1 892.1 3974.5 4006.0 4087.7 4501.3 4544.7 4209.8 4306.1 4564.0 5230.3 5245.0 3841.3 4213.9 4285.6 4562.2 4712.0 2763.7 2776.2 2780.1 2783.5 2805.2 4463.7 5428.3 5444.3 5467.2 5524.9 4868.1 5040.4 5331.9 5401.9 5406.8 4193.5 4394.7 5051.4 5235.1 5459.3 4195.4 4500.9 5126.2 5228.9 5282.5 4037.6 5518.1 5596.0 5615.0 5630.9 5413.6 5760.6 5874.0 5878.9 5886.0 3675.4 3930.8 3966.2 3998.6 3998.9 4512.5 4533.0 5547.5 5581.4 5625.7 4351.5 4788.5 5473.4 5478.5 5518.6 5142.5 5428.0 5455.4 5458.3 5465.2 4603.0 5036.1 5289.8 5377.5 5378.4 5209.5 5233.1 5351.6 5465.6 5469.5 4851.6 5344.6 5352.0 5388.0 5391.8 11:35:30 INFO - PROCESS | 1639 | 11:35:30 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20335.52 Median:4474.18 stddev:29287.99 (654.6%) stddev-sans-first:29332.69 11:35:30 INFO - PROCESS | 1639 | Values: 605.6 724.5 783.0 783.9 795.4 14239.3 14634.7 15200.9 15243.1 15446.6 13553.3 13930.4 14025.7 14028.5 14079.4 838.7 858.8 859.6 860.8 863.7 692.5 715.1 841.4 867.7 869.0 918.7 918.7 920.2 923.0 923.2 909.8 911.2 913.2 913.9 914.0 678.6 678.8 679.3 680.3 681.9 13677.2 14013.9 14047.8 14068.4 14659.3 14079.9 14309.7 14323.7 14418.5 14647.5 10174.6 10378.8 10536.9 10654.4 10939.1 4398.6 4436.4 4512.0 4534.4 4684.5 86884.6 88606.0 88815.0 89092.0 90971.0 10409.1 10620.5 10655.8 10681.8 10762.8 19618.0 19635.0 19699.2 20027.6 20036.0 7139.0 7189.6 7203.5 7363.4 7365.5 4179.3 4231.2 4299.0 4379.2 4418.7 3186.7 3293.5 3294.4 3296.7 3298.6 567.2 567.3 568.9 584.7 590.4 486.9 563.8 575.5 585.2 594.8 7282.4 8728.8 8780.3 8922.1 9056.0 571.2 597.7 603.8 613.3 622.9 4155.8 4226.2 4232.6 4291.2 4313.6 93120.5 94499.5 97668.0 98025.0 100010.0 94139.0 98497.0 101323.0 101559.0 103969.0 85551.6 85588.6 86831.0 88208.0 90351.5 8174.0 8294.2 8342.2 8345.1 8475.8 53931.0 56067.0 56073.0 56630.4 58931.8 61873.0 63118.5 64506.7 69915.0 81294.8 12604.6 12635.7 12643.7 13205.4 13447.9 11044.6 14217.4 14264.7 14347.5 15337.5 13099.5 13120.0 13437.3 13542.3 14147.8 13090.5 13203.8 13270.7 13678.8 14000.2 12685.9 12824.9 13023.7 13174.2 13931.2 11045.0 11312.4 11317.3 11414.4 11870.4 10788.8 11196.6 11392.2 11482.3 11544.5 11:35:30 INFO - PROCESS | 1639 | -------- Summary: end -------- 11:35:30 INFO - PROCESS | 1639 | 11:35:31 INFO - TEST-INFO | 1639: exit 0 11:35:31 INFO - TEST-OK | dromaeo_css | took 1117736ms 11:35:31 INFO - TEST-START | kraken 11:35:31 INFO - operating with platform_type : mac_ 11:35:31 INFO - Initialising browser for kraken test... 11:35:31 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmpAo7MtD/profile http://localhost:49235/getInfo.html) 11:35:33 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 11:35:33 INFO - PROCESS | 1650 | colorDepth:24 11:35:33 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 11:35:33 INFO - PROCESS | 1650 | __metrics 11:35:33 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:35:33 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:35:34 INFO - TEST-INFO | 1650: exit 0 11:35:34 INFO - Browser initialized. 11:35:34 INFO - Running cycle 1/1 for kraken test... 11:35:34 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmpAo7MtD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:46 INFO - PROCESS | 1652 | RSS: Main: 168710144 11:35:46 INFO - PROCESS | 1652 | 11:35:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:50 INFO - PROCESS | 1652 | RSS: Main: 218583040 11:35:50 INFO - PROCESS | 1652 | 11:35:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 11:35:53 INFO - PROCESS | 1652 | RSS: Main: 232292352 11:35:53 INFO - PROCESS | 1652 | 11:35:56 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 11:35:57 INFO - PROCESS | 1652 | RSS: Main: 328421376 11:35:57 INFO - PROCESS | 1652 | 11:35:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 11:35:59 INFO - PROCESS | 1652 | RSS: Main: 233594880 11:35:59 INFO - PROCESS | 1652 | 11:36:02 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:02 INFO - PROCESS | 1652 | RSS: Main: 234946560 11:36:02 INFO - PROCESS | 1652 | 11:36:05 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 11:36:06 INFO - PROCESS | 1652 | RSS: Main: 273747968 11:36:06 INFO - PROCESS | 1652 | 11:36:08 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:09 INFO - PROCESS | 1652 | RSS: Main: 273616896 11:36:09 INFO - PROCESS | 1652 | 11:36:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 11:36:12 INFO - PROCESS | 1652 | RSS: Main: 269914112 11:36:12 INFO - PROCESS | 1652 | 11:36:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:14 INFO - PROCESS | 1652 | RSS: Main: 249311232 11:36:14 INFO - PROCESS | 1652 | 11:36:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:17 INFO - PROCESS | 1652 | RSS: Main: 250757120 11:36:17 INFO - PROCESS | 1652 | 11:36:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:20 INFO - PROCESS | 1652 | RSS: Main: 256356352 11:36:20 INFO - PROCESS | 1652 | 11:36:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:23 INFO - PROCESS | 1652 | RSS: Main: 273584128 11:36:23 INFO - PROCESS | 1652 | 11:36:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:27 INFO - PROCESS | 1652 | RSS: Main: 266526720 11:36:27 INFO - PROCESS | 1652 | 11:36:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 11:36:29 INFO - PROCESS | 1652 | RSS: Main: 310583296 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | __start_tp_report 11:36:29 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 11:36:29 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 11:36:29 INFO - PROCESS | 1652 | |i|pagename|runs| 11:36:29 INFO - PROCESS | 1652 | |0;ai-astar;102;112;115;113;114;115;112;113;113;113 11:36:29 INFO - PROCESS | 1652 | |1;audio-beat-detection;142;107;117;179;113;107;106;109;140;115 11:36:29 INFO - PROCESS | 1652 | |2;audio-dft;181;183;184;182;186;182;182;183;181;183 11:36:29 INFO - PROCESS | 1652 | |3;audio-fft;79;57;58;90;63;63;58;59;81;49 11:36:29 INFO - PROCESS | 1652 | |4;audio-oscillator;82;69;97;70;67;70;110;97;100;103 11:36:29 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;87;84;88;85;90;85;87;85;92;131 11:36:29 INFO - PROCESS | 1652 | |6;imaging-darkroom;93;93;93;94;94;93;93;92;94;93 11:36:29 INFO - PROCESS | 1652 | |7;imaging-desaturate;87;83;79;78;81;81;83;83;83;86 11:36:29 INFO - PROCESS | 1652 | |8;json-parse-financial;54;55;52;53;57;56;55;57;55;56 11:36:29 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;64;69;72;77;72;67;69;69;68;69 11:36:29 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;86;86;81;83;82;81;81;82;83;89 11:36:29 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;144;147;150;135;135;136;139;142;187;149 11:36:29 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;162;161;159;162;159;160;159;161;161;161 11:36:29 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;67;68;66;64;65;66;79;84;84;84 11:36:29 INFO - PROCESS | 1652 | __end_tp_report 11:36:29 INFO - PROCESS | 1652 | __start_cc_report 11:36:29 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1979 11:36:29 INFO - PROCESS | 1652 | __end_cc_report 11:36:29 INFO - PROCESS | 1652 | __startTimestamp1487360189197__endTimestamp 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | ------- Summary: start ------- 11:36:29 INFO - PROCESS | 1652 | Number of tests: 14 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:3.74 (3.3%) stddev-sans-first:1.12 11:36:29 INFO - PROCESS | 1652 | Values: 102.0 112.0 115.0 113.0 114.0 115.0 112.0 113.0 113.0 113.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:116.00 stddev:23.52 (20.3%) stddev-sans-first:23.98 11:36:29 INFO - PROCESS | 1652 | Values: 142.0 107.0 117.0 179.0 113.0 107.0 106.0 109.0 140.0 115.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.49 (0.8%) stddev-sans-first:1.45 11:36:29 INFO - PROCESS | 1652 | Values: 181.0 183.0 184.0 182.0 186.0 182.0 182.0 183.0 181.0 183.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.70 Median:63.00 stddev:13.06 (20.7%) stddev-sans-first:12.93 11:36:29 INFO - PROCESS | 1652 | Values: 79.0 57.0 58.0 90.0 63.0 63.0 58.0 59.0 81.0 49.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:70.00 stddev:16.59 (23.7%) stddev-sans-first:17.52 11:36:29 INFO - PROCESS | 1652 | Values: 82.0 69.0 97.0 70.0 67.0 70.0 110.0 97.0 100.0 103.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:87.00 stddev:14.14 (16.2%) stddev-sans-first:14.90 11:36:29 INFO - PROCESS | 1652 | Values: 87.0 84.0 88.0 85.0 90.0 85.0 87.0 85.0 92.0 131.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:36:29 INFO - PROCESS | 1652 | Values: 93.0 93.0 93.0 94.0 94.0 93.0 93.0 92.0 94.0 93.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:82.40 Median:83.00 stddev:2.80 (3.4%) stddev-sans-first:2.42 11:36:29 INFO - PROCESS | 1652 | Values: 87.0 83.0 79.0 78.0 81.0 81.0 83.0 83.0 83.0 86.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.63 (2.9%) stddev-sans-first:1.69 11:36:29 INFO - PROCESS | 1652 | Values: 54.0 55.0 52.0 53.0 57.0 56.0 55.0 57.0 55.0 56.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.00 stddev:3.47 (5.0%) stddev-sans-first:3.03 11:36:29 INFO - PROCESS | 1652 | Values: 64.0 69.0 72.0 77.0 72.0 67.0 69.0 69.0 68.0 69.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.72 (3.3%) stddev-sans-first:2.71 11:36:29 INFO - PROCESS | 1652 | Values: 86.0 86.0 81.0 83.0 82.0 81.0 81.0 82.0 83.0 89.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:145.50 stddev:15.33 (10.5%) stddev-sans-first:16.24 11:36:29 INFO - PROCESS | 1652 | Values: 144.0 147.0 150.0 135.0 135.0 136.0 139.0 142.0 187.0 149.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:1.12 11:36:29 INFO - PROCESS | 1652 | Values: 162.0 161.0 159.0 162.0 159.0 160.0 159.0 161.0 161.0 161.0 11:36:29 INFO - PROCESS | 1652 | 11:36:29 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.50 stddev:8.83 (12.0%) stddev-sans-first:9.12 11:36:29 INFO - PROCESS | 1652 | Values: 67.0 68.0 66.0 64.0 65.0 66.0 79.0 84.0 84.0 84.0 11:36:29 INFO - PROCESS | 1652 | -------- Summary: end -------- 11:36:29 INFO - PROCESS | 1652 | 11:36:30 INFO - TEST-INFO | 1652: exit 0 11:36:30 INFO - TEST-OK | kraken | took 58782ms 11:36:30 INFO - SUITE-END | took 1176s 11:36:30 INFO - Completed test suite (00:19:36) 11:36:30 INFO - javascript benchmark 11:36:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.923901902452, 3445.5004024416476, 3445.9827700861492, 3458.3429148461773, 3509.666581674742, 5624.184493248482, 5680.460356266148, 5699.145128230763, 5714.799982000631, 5728.3126024876965, 4736.360591320171, 5490.780368785244, 5644.520215781653, 5742.79900203493, 5763.5101016413655, 4838.298446725223, 5150.098732721777, 5169.767360468788, 5190.558802501791, 5217.947820521803, 5124.949385375989, 5137.357830271216, 5148.124818780798, 5233.555147812441, 5302.893942121155, 4307.698461107724, 5117.976404719053, 5171.482851714836, 5182.766775495112, 5183.118869792144, 5152.819651312205, 5211.5049070338255, 5240.371155461331, 5244.108501554745, 5285.577153827685, 5118.334616499831, 5198.064348417283, 5203.16749320107, 5204.687718736888, 5215.817446389358, 5181.3782346118705, 5209.2446595243855, 5582.078956972095, 5600.327960644708, 5611.102223644198, 6149.692515374258, 6196.907046394308, 6222.315545290015, 6233.34549872266, 6240.875182496325, 6298.622082675054, 6327.8418039548915, 6331.620102793801, 6337.207849018872, 6338.651374174418, 5673.149027645886, 5727.627704199297, 5735.283089613798, 5842.824715258549, 5884.0, 6264.214698810817, 6272.780452684134, 6286.214223222098, 6292.150559674477, 6296.590721603173, 6155.2921414037955, 6162.753489860445, 6175.752969881154, 6187.319394866561, 6192.938070619236, 6110.26676798787, 6114.480269177081, 6164.722587483574, 6277.654728989858, 6297.4962003039645, 6126.9495973575995, 6140.565599444524, 6141.771645670884, 6144.9553575892205, 6169.81490555284, 6158.291796443376, 6197.442230199304, 6240.594361366497, 6260.248770147611, 6265.530085243625, 4962.975185124052, 4974.701517908937, 4979.502049795064, 4988.825391111293, 4997.825076122318, 4407.669424793154, 4425.601695847325, 4467.061916997402, 4477.216487114807, 4517.051419201939, 5679.6876171810945, 5719.027765279912, 5747.655140691572, 5748.540116790647, 5821.18503409523, 6187.783427580013, 6228.875422491525, 6258.718357673915, 6283.654399008098, 6286.465650419674, 5720.056190728483, 5750.6262092963825, 5763.308402991668, 5773.451522105393, 5776.104703770922, 5343.946560534345, 5369.731513424314, 5376.623636345496, 5383.596230282745, 5402.864928376822, 6253.874922501615, 6274.152989346379, 6276.811695649138, 6278.152449419453, 6283.465905398092, 5808.5353171747, 6083.543734219863, 6266.624002559861, 6272.372762723691, 6292.276388215414, 4995.375578052744, 6172.814815555541, 6174.289956654862, 6233.532485063548, 6253.218347706536, 6085.66528840918, 6123.008104567321, 6163.753449861955, 6165.260168779775, 6198.907016394667, 6216.0, 6220.906686399798, 6222.222222222223, 6231.875362492816, 6234.563580549499, 5006.574441172541, 5969.0, 6029.547783916311, 6081.39186081406, 6111.113888486056, 6066.848328791815, 6092.908606370819, 6117.005394430456, 6172.475339596184, 6180.47465965398, 5962.850928726816, 5988.341282458839, 6008.54935879802, 6013.819585412444, 6032.426919442646, 5896.262967129109, 6116.785912493041, 6143.84640383994, 6146.723397447215, 6154.415330543591, 5861.9706901465215, 5869.618474799125, 5888.352281249145, 5925.111233315038, 5972.193753843349], "value": 5665.263661965575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.2954357095071, 489.5178249424316, 490.92145256758903, 535.7696190638027, 549.4340828946187, 30770.230744231376, 32791.34417311655, 39363.80318098409, 40281.395779063336, 40652.39021414681, 41157.0, 42277.0, 42503.78748106263, 42604.57395426045, 42669.35995960055, 9382.859257111131, 9505.334626576143, 9510.429374237568, 9516.143547080761, 9533.904660953405, 8670.176333248332, 8886.822263554724, 11308.943455282712, 11520.0, 11554.364509951949, 11428.314301141916, 11500.367479788609, 11509.827352589718, 11522.942385288063, 11539.134564907623, 11318.151138664633, 11352.772944541062, 11387.829182562185, 11390.658280251648, 11395.715107122305, 11396.145289103268, 11470.139739519485, 11475.827862582068, 11479.196456248066, 11480.253783504046, 39336.60663393358, 39573.0, 39621.0, 39742.80128599339, 39852.800735996425, 3402.6937575618067, 3483.3555792178277, 3597.6402359764074, 3765.7363984521094, 3942.8225729842225, 28411.0, 29286.707132928612, 29724.0, 30844.691553084405, 31867.725290988332, 3132.530120481923, 3174.0477856643147, 3239.4492936200904, 3312.5362449257123, 3352.312775880963, 364831.1758441217, 365749.0, 366347.0, 367341.0, 473770.63114684896, 58181.0, 58337.4166258332, 58348.70825645845, 58401.123983140285, 58584.12123818146, 60358.0, 60360.0, 60387.39612603818, 60462.39537604568, 60500.0, 16128.354865805471, 16411.0, 16411.83588164127, 16416.589585260463, 16434.83565164357, 11719.941400293115, 11953.103517236243, 12779.872201277869, 12889.097763156677, 12889.548865789653, 14173.574792756233, 14264.714705705828, 14265.928670356581, 14299.64250893736, 15136.318865651072, 5445.482679145475, 6168.691565421801, 6465.988858634596, 6485.967570162214, 6564.245111812107, 852.3309202276183, 969.1471505075489, 989.5893204320271, 1007.9143272821746, 1062.4103622489592, 27682.508574228417, 28590.857045715053, 28634.427311453655, 29372.853135734185, 29468.11595652134, 865.4634126841398, 899.6851102114339, 1041.6042503045956, 1051.5791096895516, 1104.9779004419865, 14987.925060374628, 15073.095614263179, 15135.924320378328, 15341.923290383476, 15456.381744730084, 629294.0, 633129.0, 636505.0, 636524.0, 659704.0, 45641.0, 55443.89112217733, 56487.0, 56680.0, 59891.0, 1364.2973868457752, 1371.7942308653583, 1419.176877411099, 1422.2035660030417, 1426.1656930695451, 25966.48067038611, 29345.266368340108, 30179.09462716122, 30219.546706799854, 30643.2339191522, 39153.608463916134, 48599.54201373964, 48628.541143765746, 48711.26933096077, 48732.51267487422, 539009.0, 541433.0, 541639.0, 542656.0, 543496.0, 37716.43425348567, 37966.620333797415, 38498.6150138495, 38609.0, 38685.0, 44725.776371117936, 45219.09561808811, 45578.77210613926, 46325.536744632125, 46602.300965484865, 37146.8142659285, 37223.0, 37341.81329093337, 37468.81265593655, 38752.41871371988, 37009.81495092507, 37462.8126859364, 38427.42358864675, 38438.039049023995, 38498.80750596229, 36456.63543364532, 36905.63094369022, 37588.436173457965, 37983.0, 38441.231175376895, 31933.680663194, 33971.83014084914, 33974.660253398135, 34014.48978265279, 34062.829685851415, 24590.0, 24744.381390465383, 24945.875270623532, 25110.0, 25652.102176424483], "value": 19822.80149909827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.0927445298431, 385.09502668728476, 388.9222155568886, 397.6878150651738, 411.96086371794667, 15287.464938727147, 15498.457553985612, 18425.907870460647, 20332.08505617247, 20841.749495030308, 18956.905215473937, 19602.901985490054, 20057.799422005777, 20187.899060504715, 20199.38404927602, 5703.828885133442, 5795.15970184323, 5827.300723913137, 5828.883422331572, 5973.22348094747, 5936.198613187207, 6148.508119350441, 6153.476954458876, 6164.907526387108, 6172.043333283348, 5689.829305120853, 6020.608660437079, 6056.212692349988, 6107.4808641265545, 6113.868934247179, 5995.280566332046, 6025.427584379477, 6032.276126864783, 6074.787382441637, 6584.242812076624, 5890.057590785454, 5891.499222566087, 5895.64626122434, 5895.675737834417, 5898.675572843492, 13165.210087394787, 15683.0, 20362.490937726674, 25124.874375628187, 25357.74642253572, 2205.669149627569, 2359.64605309205, 2494.301595553248, 2649.5098406794614, 2972.806767560102, 8056.436049476539, 9864.408135511892, 9868.506574671237, 9939.453330066843, 10398.376097434179, 1801.3425099838464, 1826.2877477783543, 1854.5919897622503, 1876.0807204469847, 1932.468571142947, 99675.0, 113823.43088284589, 115178.42410787892, 115474.42262788716, 115534.99999999916, 11580.189386743015, 11612.76774464506, 11746.17776755636, 11762.235454695418, 11895.334653148566, 15017.549473515812, 15034.473793417177, 15035.774463383059, 15042.699146017017, 15055.698886022219, 7448.590327532038, 7987.881696562486, 8579.613917373608, 8586.742397728078, 8743.825123497494, 8448.239658430648, 8454.026092428474, 8477.745667629857, 8623.137686231326, 8639.568021598894, 4572.8399506017795, 4580.328180214265, 4609.677322587387, 4613.192691279013, 4657.115148121914, 1457.5044484875193, 1862.835727670206, 1871.8970456625016, 1928.305809908432, 1931.33368987699, 888.5424006636588, 894.3158483759929, 915.2220612479339, 949.8100379924043, 1007.6876168387823, 18721.31508164272, 19759.40721778349, 20276.79723202749, 21364.359069227947, 21837.45406364822, 907.9137481939205, 933.8319102561468, 945.0879900895532, 949.8717673114041, 985.7535616095976, 11047.558097676163, 11310.377929213808, 11328.546858125583, 11350.48922798476, 11359.488823002985, 598779.0, 603062.9846850826, 612434.0, 616172.0, 617138.0, 134061.0, 134647.0, 135086.0, 135900.0, 137013.0, 936.0826390137703, 968.6997030920437, 994.1947022911465, 997.0378584665832, 997.6209040564684, 16558.503244902673, 18156.092195390444, 19721.506962326057, 19722.704159437333, 19723.704144438132, 42950.0, 52843.47156528386, 53731.462685372644, 55595.44404555903, 57076.71461642831, 75567.62216188884, 77729.61135194288, 79850.41421064989, 79963.60018199871, 83580.0, 10911.727206819893, 11911.404429778304, 12084.879151208375, 12260.892600978772, 12333.50665973351, 12249.571265005681, 12666.240025598494, 13447.596572102853, 13484.932575337061, 13956.302184890917, 5642.23829782974, 11272.210945233755, 11485.655430337103, 11915.344656044, 11953.880461195276, 8056.395770317133, 9467.857982130135, 11592.768144637228, 11934.52261909514, 12115.515379384726, 7939.444238903221, 8119.634616442392, 8156.0, 8160.020797504338, 8226.794330141794, 11865.762684746429, 12429.813552796897, 12724.554640587536, 12735.108542401942, 12789.296588687712, 11529.884701153216, 11557.88442115568, 11599.304041757521, 12077.456514457046, 12085.637430877088], "value": 9673.390496973214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.9259190744506, 1485.1905711387296, 1507.1409296700879, 1687.232309299269, 1861.5160058384815, 7427.183009868917, 7821.10057343405, 8039.959800201005, 8247.134050924642, 8265.462744921591, 8138.715144969928, 8254.504729716222, 8258.009038915323, 8258.958705206465, 8259.050209225941, 2253.740819805723, 2294.9311520654323, 2295.850769699964, 2296.7932886040253, 2298.367948814073, 2282.167009041696, 2316.733575638798, 2347.3427440316736, 2347.4366152123453, 2350.9059637614473, 2322.7328857181387, 2334.0663734506247, 2354.176038386568, 2358.882055897207, 2365.0303375616, 2317.1774020222747, 2321.7446080931086, 2329.5340931813703, 2350.4123969007833, 2351.729551101628, 2335.556244313592, 2361.1971929543865, 2364.645303204516, 2366.6095094309417, 2368.2539999899977, 8109.107998120202, 8268.83462330756, 8299.751007469786, 8309.8338033239, 8318.916810831935, 5017.397912250517, 5211.218317252405, 5213.3743950725775, 5260.815871444519, 5267.86830329241, 3248.2297148054367, 3508.3509550733197, 3570.589382221052, 3575.6781889630056, 3576.409892367756, 1045.2004216774174, 1069.6630561373142, 1101.2181351240629, 1112.0825319111766, 1116.1573012375604, 10824.512896919658, 10844.2951208172, 10939.124870010459, 10960.01359877607, 10961.780764384668, 3825.6939444844347, 4254.957450425456, 4411.7867586413995, 4442.711223770445, 4493.213687604656, 7816.843663126706, 8674.826503469896, 8679.652813887375, 8703.521306328086, 8707.825843483095, 5014.52362025607, 5106.208537676666, 5107.0, 5111.437741848394, 5112.616553758483, 4109.486314210723, 4323.783810809447, 4443.755593442392, 4465.955340446554, 4802.73584952831, 3654.3239500692457, 3706.388445906395, 3783.697304215656, 3792.8482860685262, 3794.79128647927, 1107.5071593141136, 1108.545496346494, 1108.6729414822646, 1108.8503052088026, 1115.8605174353206, 770.3413581387945, 795.9930687679973, 840.6469282901196, 884.6726711116928, 912.412402419798, 5355.0, 5607.859803504945, 5634.690092044977, 5738.0, 5905.822825315247, 438.68195558220674, 459.08412716630534, 466.4379422795523, 468.39810843067175, 472.4613940108279, 3785.6025117362833, 3839.865604703822, 3927.430522574268, 3930.0, 3949.861754838567, 9768.316217864682, 10042.74893127663, 10125.493725313705, 10129.240306977006, 10144.695659130239, 9544.809103818023, 9782.657606983863, 10057.748556286151, 10085.899141008642, 10225.897741022494, 7710.036245469317, 7778.49439786412, 7781.377489800802, 7900.920990790133, 7914.802129946682, 5733.111367738007, 5749.13762935563, 5796.9420305798085, 5819.359870414166, 5930.28836539618, 8987.685431009882, 9247.537623118682, 9337.0, 9362.876454825464, 9373.812523749622, 7905.881411778713, 8787.121287871161, 9063.184313411824, 9654.517274136406, 9660.130588247092, 5696.401877802771, 7104.147502299757, 7151.141862976476, 7247.2390399009455, 7262.527935684164, 7674.8081297968, 7887.014123234596, 7972.84054318922, 8096.392770542115, 8097.2712455879255, 7155.248698886542, 7206.495545311987, 7250.746223882139, 7252.818679532843, 7377.151627562899, 6936.895946560907, 6947.75682851118, 6962.094927659372, 6991.2309645937885, 7009.053777740144, 6668.29982851813, 6722.932770672231, 6735.865282694221, 6756.662166891734, 6767.593944363354, 4795.9280610790165, 4831.299461578122, 4838.588719958843, 4901.215805471107, 4943.5797957174045, 4789.9042019160115, 4793.952060479351, 4815.181419158822, 4979.327790748347, 5126.4617215191865], "value": 4296.974971390519, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.7700147378413, 308.1464343767763, 315.87522928443263, 320.845993922917, 322.64509040055924, 4622.399088118544, 4759.738214398211, 4934.28452874333, 4987.002599480109, 5225.529702326795, 4017.4375587417785, 4325.480942286922, 5052.823151189709, 5085.135526960416, 5085.694858308504, 3570.2680950405233, 3899.3038028457568, 3961.6038396160443, 3994.641821780594, 4015.927815221358, 3191.952120718191, 3957.9208415831667, 3994.101327201371, 3997.2405243003736, 4004.7797371144575, 3217.7747557670973, 3661.3775658138047, 3914.7846868422225, 3969.30537155998, 4031.97984010081, 3430.451127819562, 3967.1272320089533, 3968.40473928913, 3985.2826491231567, 4003.4795476588147, 3469.340825243221, 3486.808225547594, 3487.9128021799406, 3491.6857482826667, 3512.8243587820507, 4770.015333976004, 4955.36472963921, 5012.195609580548, 5012.774425150877, 5013.072581572421, 4480.244649540509, 4481.305397663367, 4481.820727170909, 4514.345419914127, 4525.343825145368, 4886.633502487292, 5273.578113750929, 5339.813106541253, 5363.383210930754, 5398.946010539884, 3076.0, 3227.7579181561478, 3798.4236541835107, 3802.524684414448, 3842.4620553122586, 5459.727013649302, 5527.364353099365, 5585.776568937278, 5605.103183490622, 5611.2144299798065, 3601.3517566837695, 3612.9277414451562, 3856.8842934712, 3878.6897048236074, 3896.5713771485116, 3785.2240290740883, 3927.6842257843373, 3946.2699400610977, 3948.4669569607736, 3949.3483575210344, 4315.532718875597, 4444.511103778582, 4486.461624605068, 4502.482214545369, 4545.977155140133, 5045.0, 5093.719845408538, 5352.357717073976, 5356.330458692663, 5386.730663466889, 1107.4495706011649, 1175.3594291111365, 1212.5574165429555, 1243.6952946528158, 1254.9121561490608, 777.8794286885542, 822.658596682382, 860.2773670117132, 870.0994470722771, 892.1435421994828, 3974.463447434617, 4005.9799701001893, 4087.7138600297694, 4501.279795232747, 4544.6818722689095, 4209.768462734579, 4306.0526684129445, 4563.956827705338, 5230.34620672416, 5244.9737751310995, 3841.2893614681375, 4213.936790948138, 4285.571442855752, 4562.1560011398, 4711.952880471152, 2763.69599344072, 2776.237643544686, 2780.124260857823, 2783.4711404833015, 2805.2145399288233, 4463.732176069446, 5428.348598168245, 5444.346678398618, 5467.152591348347, 5524.889502209933, 4868.075065737569, 5040.445550989388, 5331.920021199685, 5401.918971215435, 5406.810761623325, 4193.517745459311, 4394.670399720034, 5051.4443411224, 5235.110031294689, 5459.334902854667, 4195.433616461861, 4500.887477813081, 5126.154184559506, 5228.921566176587, 5282.524572788468, 4037.6164264394833, 5518.06192947208, 5595.964746521907, 5615.0, 5630.943690563042, 5413.56691464674, 5760.596758226884, 5874.03078492044, 5878.882422351615, 5886.0, 3675.4303083022173, 3930.803459827054, 3966.2464131814863, 3998.6401223888824, 3998.900027499336, 4512.481064677473, 4532.954670453385, 5547.528460080777, 5581.413951535031, 5625.746841392229, 4351.477822661174, 4788.473267940454, 5473.397926228191, 5478.479544443271, 5518.558515318845, 5142.460041695717, 5428.0, 5455.399906010415, 5458.344998600193, 5465.234867118686, 4602.953970460252, 5036.147347279408, 5289.788408463773, 5377.542908852792, 5378.354597448175, 5209.47905209476, 5233.084210263265, 5351.625386222927, 5465.6447330923365, 5469.480399362054, 4851.563359297539, 5344.5991550634635, 5352.0, 5387.973060134675, 5391.838244852661], "value": 3885.9531325246694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.5791225098557, 724.5399171526079, 782.9821232397882, 783.8745800671886, 795.4431897671632, 14239.288035598218, 14634.707305853877, 15200.923995380008, 15243.085414875115, 15446.61383465414, 13553.254570998615, 13930.373133209005, 14025.719485610281, 14028.509002184926, 14079.366428510715, 838.6980686952692, 858.8325276571071, 859.6346552715103, 860.8063185783211, 863.6933888469597, 692.4737199728193, 715.1096884378956, 841.4026041510535, 867.6876324523198, 869.0180096490988, 918.660095764568, 918.678462538113, 920.2499962530517, 922.9815403691922, 923.2383283790866, 909.8316811389914, 911.1662828511903, 913.1963871792813, 913.9497327646977, 914.0, 678.5894533807025, 678.7963610916754, 679.3342524326188, 680.3366717450496, 681.8534015186709, 13677.24775137377, 14013.929930350385, 14047.78928316076, 14068.366923488366, 14659.34032968519, 14079.929600352036, 14309.713805723828, 14323.665707893913, 14418.49535266271, 14647.529759822568, 10174.643887463977, 10378.827192527235, 10536.894631053668, 10654.4140072296, 10939.070179034792, 4398.560143985608, 4436.401085853433, 4511.954880451186, 4534.36518887356, 4684.464451632456, 86884.56557717171, 88606.0, 88815.0, 89092.0, 90970.99999999935, 10409.063184313449, 10620.468976551141, 10655.84016239757, 10681.786364272672, 10762.838557421645, 19618.0, 19635.0, 19699.212031518866, 20027.59944801125, 20036.0, 7139.0, 7189.571783645376, 7203.531770434905, 7363.410927125817, 7365.521241119417, 4179.28316663758, 4231.174920890458, 4298.989737411705, 4379.211741886491, 4418.7127836690515, 3186.729128024144, 3293.4730443128983, 3294.40700673881, 3296.6703329666843, 3298.5546951161764, 567.2115759094861, 567.2512283785446, 568.8634727665413, 584.7310237290809, 590.3594599859115, 486.93669822922794, 563.811123273708, 575.4648177195165, 585.2479563760547, 594.8275000249965, 7282.417406607458, 8728.825423491622, 8780.297576193889, 8922.063183365783, 9055.95472022649, 571.1603942204952, 597.6862147372664, 603.7766026570109, 613.2916481463916, 622.9159063526456, 4155.750654960712, 4226.1758957003085, 4232.555581663943, 4291.154217083054, 4313.61177494027, 93120.53439732757, 94499.52750236342, 97668.0, 98025.03949920961, 100009.99990000152, 94139.0, 98497.0, 101322.98677013283, 101559.0, 103969.0, 85551.5722421384, 85588.57205714055, 86830.99999999873, 88208.0, 90351.54824225837, 8174.019117705676, 8294.170582941657, 8342.249197572248, 8345.082040975609, 8475.788105297417, 53931.0, 56067.0, 56073.0, 56630.43369566252, 58931.81215972261, 61873.0, 63118.47526098905, 64506.67746661237, 69915.0, 81294.78057829019, 12604.55884044054, 12635.684107897376, 12643.747125057631, 13205.405756740778, 13447.865521344662, 11044.613438529614, 14217.360218789972, 14264.714705706036, 14347.497837575635, 15337.539873803804, 13099.476020959437, 13120.0, 13437.260950647807, 13542.322883855964, 14147.787783183467, 13090.541831035867, 13203.801942971055, 13270.668233294246, 13678.794818077538, 14000.159990400609, 12685.873141268468, 12824.871751282368, 13023.739525209254, 13174.187403262613, 13931.233782142079, 11045.0, 11312.434378281218, 11317.264377815416, 11414.429278536207, 11870.406479675808, 10788.838167427652, 11196.600424946882, 11392.15295757837, 11482.311061336346, 11544.538218471167], "value": 7292.129031920108, "unit": "score"}], "name": "dromaeo_css", "value": 7138.192122293568, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 115.0, 113.0, 114.0, 115.0, 112.0, 113.0, 113.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 107.0, 117.0, 179.0, 113.0, 107.0, 106.0, 109.0, 140.0, 115.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 184.0, 182.0, 186.0, 182.0, 182.0, 183.0, 181.0, 183.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 58.0, 90.0, 63.0, 63.0, 58.0, 59.0, 81.0, 49.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 97.0, 70.0, 67.0, 70.0, 110.0, 97.0, 100.0, 103.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 85.0, 90.0, 85.0, 87.0, 85.0, 92.0, 131.0], "value": 91.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 92.0, 94.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 79.0, 78.0, 81.0, 81.0, 83.0, 83.0, 83.0, 86.0], "value": 82.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 52.0, 53.0, 57.0, 56.0, 55.0, 57.0, 55.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 72.0, 77.0, 72.0, 67.0, 69.0, 69.0, 68.0, 69.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 81.0, 83.0, 82.0, 81.0, 81.0, 82.0, 83.0, 89.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 147.0, 150.0, 135.0, 135.0, 136.0, 139.0, 142.0, 187.0, 149.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 159.0, 162.0, 159.0, 160.0, 159.0, 161.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 64.0, 65.0, 66.0, 79.0, 84.0, 84.0, 84.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1425.2, "alertThreshold": 2.0}]} 11:36:30 INFO - Return code: 0 11:36:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:36:30 INFO - # TBPL SUCCESS # 11:36:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:36:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:36:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:36:30 INFO - 2017-02-17 11:36:30.487 screenresolution[1656:9718] starting screenresolution argv=screenresolution get 11:36:30 INFO - 2017-02-17 11:36:30.490 screenresolution[1656:9718] Display 0: 1600x1200x32@60 11:36:30 INFO - 2017-02-17 11:36:30.496 screenresolution[1657:9721] starting screenresolution argv=screenresolution list 11:36:30 INFO - Available Modes on Display 0 11:36:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:36:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:36:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:36:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:36:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:36:30 INFO - Intel Iris: 11:36:30 INFO - Chipset Model: Intel Iris 11:36:30 INFO - Type: GPU 11:36:30 INFO - Bus: Built-In 11:36:30 INFO - VRAM (Dynamic, Max): 1536 MB 11:36:30 INFO - Vendor: Intel (0x8086) 11:36:30 INFO - Device ID: 0x0a2e 11:36:30 INFO - Revision ID: 0x0009 11:36:30 INFO - Displays: 11:36:30 INFO - Display: 11:36:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:36:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:36:30 INFO - Display Serial Number: 1600x1200 60 11:36:30 INFO - Main Display: Yes 11:36:30 INFO - Mirror: Off 11:36:30 INFO - Online: Yes 11:36:30 INFO - Rotation: Supported 11:36:30 INFO - Return code: 0 11:36:30 INFO - Running post-action listener: _resource_record_post_action 11:36:30 INFO - [mozharness: 2017-02-17 19:36:30.738671Z] Finished run-tests step (success) 11:36:30 INFO - Running post-run listener: _resource_record_post_run 11:36:30 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 37069824; Write bytes: 495276032; Read time: 389; Write time: 1478 11:36:30 INFO - TinderboxPrint: CPU usage
53.3% 11:36:30 INFO - TinderboxPrint: I/O read bytes / time
37,069,824 / 389 11:36:30 INFO - TinderboxPrint: I/O write bytes / time
495,276,032 / 1,478 11:36:30 INFO - TinderboxPrint: CPU idle
2,237.7 (46.7%) 11:36:30 INFO - TinderboxPrint: CPU system
954.4 (19.9%) 11:36:30 INFO - TinderboxPrint: CPU user
1,601.5 (33.4%) 11:36:30 INFO - TinderboxPrint: Swap in / out
228,769,792 / 0 11:36:30 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 187369984; Write bytes: 186572800; Read time: 17137; Write time: 331 11:36:30 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36144128; Write bytes: 302661632; Read time: 376; Write time: 1121 11:36:31 INFO - Running post-run listener: _upload_blobber_files 11:36:31 INFO - Blob upload gear active. 11:36:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:36:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:36:31 INFO - (blobuploader) - INFO - Open directory for files ... 11:36:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:36:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:36:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:32 INFO - (blobuploader) - INFO - Done attempting. 11:36:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:36:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:36:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:33 INFO - (blobuploader) - INFO - Done attempting. 11:36:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:36:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:36:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:35 INFO - (blobuploader) - INFO - Done attempting. 11:36:35 INFO - (blobuploader) - INFO - Iteration through files over. 11:36:35 INFO - Return code: 0 11:36:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:36:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:36:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb8e43ddfbd510f27b714e644672d023b85df26c56f5da7b3be02b3920b33643c249b9b89e312b822064b8d0942aca8fb86106170c468a7cecbb30b15a20ebdc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2de05593ab58a45a8d2274deed37b0d7bf37377cb8ceb32dde87daa890b298d05804682e13287308e638b6d259ca4fd6df7a05b944043b3240924258cdb9ec8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe0e8bf45e435f9eb9e7f5555823e4759c4e3695cd56f670fb1a0bcd84ab3385471794b3ea3d94dd6fb24e674a90d58e73b50cb73e29ebebfc57cbfb7abe02d7"} 11:36:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:36:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:36:35 INFO - Contents: 11:36:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb8e43ddfbd510f27b714e644672d023b85df26c56f5da7b3be02b3920b33643c249b9b89e312b822064b8d0942aca8fb86106170c468a7cecbb30b15a20ebdc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2de05593ab58a45a8d2274deed37b0d7bf37377cb8ceb32dde87daa890b298d05804682e13287308e638b6d259ca4fd6df7a05b944043b3240924258cdb9ec8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe0e8bf45e435f9eb9e7f5555823e4759c4e3695cd56f670fb1a0bcd84ab3385471794b3ea3d94dd6fb24e674a90d58e73b50cb73e29ebebfc57cbfb7abe02d7"} 11:36:35 INFO - Running post-run listener: copy_logs_to_upload_dir 11:36:35 INFO - Copying logs to upload dir... 11:36:35 INFO - mkdir: /builds/slave/test/build/upload/logs 11:36:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.968545 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-17 11:36:36.041354) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 11:36:36.045223) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lMxpRE7g1M/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb8e43ddfbd510f27b714e644672d023b85df26c56f5da7b3be02b3920b33643c249b9b89e312b822064b8d0942aca8fb86106170c468a7cecbb30b15a20ebdc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2de05593ab58a45a8d2274deed37b0d7bf37377cb8ceb32dde87daa890b298d05804682e13287308e638b6d259ca4fd6df7a05b944043b3240924258cdb9ec8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe0e8bf45e435f9eb9e7f5555823e4759c4e3695cd56f670fb1a0bcd84ab3385471794b3ea3d94dd6fb24e674a90d58e73b50cb73e29ebebfc57cbfb7abe02d7"} build_url:https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011024 build_url: 'https://queue.taskcluster.net/v1/task/AtcC6PuASsibVrPKs2Ckzw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb8e43ddfbd510f27b714e644672d023b85df26c56f5da7b3be02b3920b33643c249b9b89e312b822064b8d0942aca8fb86106170c468a7cecbb30b15a20ebdc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2de05593ab58a45a8d2274deed37b0d7bf37377cb8ceb32dde87daa890b298d05804682e13287308e638b6d259ca4fd6df7a05b944043b3240924258cdb9ec8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fe0e8bf45e435f9eb9e7f5555823e4759c4e3695cd56f670fb1a0bcd84ab3385471794b3ea3d94dd6fb24e674a90d58e73b50cb73e29ebebfc57cbfb7abe02d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 11:36:36.080034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 11:36:36.080335) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lMxpRE7g1M/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.Tf9jkNg0e2/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005106 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 11:36:36.128512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 11:36:36.128833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 11:36:36.129179) ========= ========= Total master_lag: 0.18 =========