builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0375 starttime: 1485885554.09 results: success (0) buildid: 20170131074809 builduid: d9d199b0242e4fba832eb3cc8c0d1158 revision: d859990cc3113332b24cc0088c8d75fbe5471775 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:14.092101) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:14.092594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:14.092867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:14.120229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:14.120579) ========= 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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-01-31 09:59:14-- 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% 125M=0s 2017-01-31 09:59:14 (125 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125194 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:14.268871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:14.269179) ========= 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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.019178 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:14.322029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:14.324404) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d859990cc3113332b24cc0088c8d75fbe5471775 --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 d859990cc3113332b24cc0088c8d75fbe5471775 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-01-31 09:59:14,416 truncating revision to first 12 chars 2017-01-31 09:59:14,416 Setting DEBUG logging. 2017-01-31 09:59:14,416 attempt 1/10 2017-01-31 09:59:14,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d859990cc311?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 09:59:15,062 unpacking tar archive at: mozilla-beta-d859990cc311/testing/mozharness/ program finished with exit code 0 elapsedTime=0.889664 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:15.234020) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:15.234355) ========= script_repo_revision: d859990cc3113332b24cc0088c8d75fbe5471775 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:15.234725) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:15.234992) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 09:59:15.256223) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-31 09:59:15.256588) ========= /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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 09:59:15 INFO - MultiFileLogger online at 20170131 09:59:15 in /builds/slave/test 09:59:15 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 09:59:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:15 INFO - {'append_to_log': False, 09:59:15 INFO - 'base_work_dir': '/builds/slave/test', 09:59:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:59:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:15 INFO - 'branch': 'Mozilla-Beta', 09:59:15 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:15 INFO - 'config_files': ('talos/mac_config.py',), 09:59:15 INFO - 'default_actions': ('clobber', 09:59:15 INFO - 'read-buildbot-config', 09:59:15 INFO - 'download-and-extract', 09:59:15 INFO - 'populate-webroot', 09:59:15 INFO - 'create-virtualenv', 09:59:15 INFO - 'install', 09:59:15 INFO - 'run-tests'), 09:59:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:15 INFO - 'download_minidump_stackwalk': True, 09:59:15 INFO - 'download_symbols': 'ondemand', 09:59:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:15 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:15 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:15 INFO - 'installer_path': 'installer.exe', 09:59:15 INFO - 'log_level': 'info', 09:59:15 INFO - 'log_name': 'talos', 09:59:15 INFO - 'log_to_console': True, 09:59:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:59:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:59:15 INFO - 'opt_config_files': (), 09:59:15 INFO - 'pip_index': False, 09:59:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:59:15 INFO - 'cmd': ('bash', 09:59:15 INFO - '-c', 09:59:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:59:15 INFO - 'enabled': True, 09:59:15 INFO - 'halt_on_failure': False, 09:59:15 INFO - 'name': 'check_screen_resolution'},), 09:59:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:59:15 INFO - 'cmd': ('bash', 09:59:15 INFO - '-c', 09:59:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:59:15 INFO - 'enabled': True, 09:59:15 INFO - 'halt_on_failure': False, 09:59:15 INFO - 'name': 'check_screen_resolution'},), 09:59:15 INFO - 'run_cmd_checks_enabled': True, 09:59:15 INFO - 'sps_profile': False, 09:59:15 INFO - 'sps_profile_interval': 0, 09:59:15 INFO - 'suite': 'dromaeojs', 09:59:15 INFO - 'system_bits': '32', 09:59:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:15 INFO - 'title': 't-yosemite-r7-0375', 09:59:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:15 INFO - 'use_talos_json': True, 09:59:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:15 INFO - 'work_dir': 'build'} 09:59:15 INFO - [mozharness: 2017-01-31 17:59:15.458737Z] Running clobber step. 09:59:15 INFO - Running pre-action listener: _resource_record_pre_action 09:59:15 INFO - Running main action method: clobber 09:59:15 INFO - rmtree: /builds/slave/test/build 09:59:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:17 INFO - Running post-action listener: _resource_record_post_action 09:59:17 INFO - [mozharness: 2017-01-31 17:59:17.081182Z] Finished clobber step (success) 09:59:17 INFO - [mozharness: 2017-01-31 17:59:17.081368Z] Running read-buildbot-config step. 09:59:17 INFO - Running pre-action listener: _resource_record_pre_action 09:59:17 INFO - Running main action method: read_buildbot_config 09:59:17 INFO - Using buildbot properties: 09:59:17 INFO - { 09:59:17 INFO - "project": "", 09:59:17 INFO - "product": "firefox", 09:59:17 INFO - "script_repo_revision": "production", 09:59:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:59:17 INFO - "repository": "", 09:59:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:59:17 INFO - "buildid": "20170131074809", 09:59:17 INFO - "pgo_build": "False", 09:59:17 INFO - "basedir": "/builds/slave/test", 09:59:17 INFO - "buildnumber": 20, 09:59:17 INFO - "slavename": "t-yosemite-r7-0375", 09:59:17 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:59:17 INFO - "platform": "yosemite_r7", 09:59:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:59:17 INFO - "branch": "mozilla-beta", 09:59:17 INFO - "repo_path": "releases/mozilla-beta", 09:59:17 INFO - "revision": "d859990cc3113332b24cc0088c8d75fbe5471775", 09:59:17 INFO - "stage_platform": "macosx64", 09:59:17 INFO - "builduid": "d9d199b0242e4fba832eb3cc8c0d1158", 09:59:17 INFO - "slavebuilddir": "test" 09:59:17 INFO - } 09:59:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 09:59:17 INFO - Running post-action listener: _resource_record_post_action 09:59:17 INFO - [mozharness: 2017-01-31 17:59:17.084699Z] Finished read-buildbot-config step (success) 09:59:17 INFO - [mozharness: 2017-01-31 17:59:17.084816Z] Running download-and-extract step. 09:59:17 INFO - Running pre-action listener: _resource_record_pre_action 09:59:17 INFO - Running main action method: download_and_extract 09:59:17 INFO - mkdir: /builds/slave/test/build/tests 09:59:17 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')]} 09:59:17 INFO - trying https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 09:59:17 INFO - Downloading https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/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 09:59:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/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 09:59:18 INFO - Downloaded 1165 bytes. 09:59:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:59:18 INFO - Using the following test package requirements: 09:59:18 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:59:18 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:59:18 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 09:59:18 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:59:18 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 09:59:18 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:59:18 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:59:18 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 09:59:18 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:59:18 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:59:18 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 09:59:18 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:59:18 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 09:59:18 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:59:18 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 09:59:18 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:59:18 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 09:59:18 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 09:59:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:59:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:59:18 INFO - Fetch https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:59:19 INFO - Http code: 200 09:59:19 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 09:59:19 INFO - x-amz-cf-id: x5YsQgE56qKVEMf3xmziqiKmA7VDMp_qCL6wkaI8QkNvuTF06Hw3fQ== 09:59:19 INFO - x-amz-version-id: o8n7eZXpvzZEgzfV2551r4Yu_bKCuxA9 09:59:19 INFO - Expected file size: 16089047 09:59:19 INFO - Obtained file size: 16089047 09:59:25 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 09:59:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:59:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:59:25 INFO - Fetch https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:59:26 INFO - Http code: 200 09:59:26 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 09:59:26 INFO - x-amz-cf-id: DcPQzgtKQwoXQNLOWV7ZNCqxBd0nTvTn2oIVK9B_9TKUiCsogeSa8w== 09:59:26 INFO - x-amz-version-id: o8n7eZXpvzZEgzfV2551r4Yu_bKCuxA9 09:59:26 INFO - Expected file size: 16089047 09:59:26 INFO - Obtained file size: 16089047 09:59:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 09:59:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 09:59:32 INFO - Fetch https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 09:59:33 INFO - Http code: 200 09:59:33 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 09:59:33 INFO - x-amz-cf-id: ytp_3PjZyZTt7o0YN2DwAkx2vCZiMyol168PQQnIvqdU80Y45qVY-A== 09:59:33 INFO - x-amz-version-id: C0ko1KdB30sS3LRisByEN1v_iKs55SBq 09:59:33 INFO - Expected file size: 14402992 09:59:33 INFO - Obtained file size: 14402992 09:59:34 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')]} 09:59:34 INFO - trying https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:59:34 INFO - Downloading https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 09:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/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 09:59:37 INFO - Downloaded 82145081 bytes. 09:59:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:59:37 INFO - mkdir: /builds/slave/test/properties 09:59:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:59:37 INFO - Writing to file /builds/slave/test/properties/build_url 09:59:37 INFO - Contents: 09:59:37 INFO - build_url:https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:59:38 INFO - Running post-action listener: _resource_record_post_action 09:59:38 INFO - Running post-action listener: set_extra_try_arguments 09:59:38 INFO - [mozharness: 2017-01-31 17:59:38.179611Z] Finished download-and-extract step (success) 09:59:38 INFO - [mozharness: 2017-01-31 17:59:38.179766Z] Running populate-webroot step. 09:59:38 INFO - Running pre-action listener: _resource_record_pre_action 09:59:38 INFO - Running main action method: populate_webroot 09:59:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:59:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:59:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:59:38 INFO - '--tppagecycles', 09:59:38 INFO - '7'], 09:59:38 INFO - 'tests': ['tsvgm']}}, 09:59:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:59:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:59:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:59:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:59:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['damp', 'tps']}, 09:59:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'tests': ['damp', 'tps']}, 09:59:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['dromaeo_dom']}, 09:59:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:59:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['basic_compositor_video']}, 09:59:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:59:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'other-e10s': {'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['a11yr', 09:59:38 INFO - 'ts_paint', 09:59:38 INFO - 'tpaint', 09:59:38 INFO - 'sessionrestore', 09:59:38 INFO - 'sessionrestore_no_auto_restore', 09:59:38 INFO - 'tabpaint']}, 09:59:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['tsvgx', 09:59:38 INFO - 'tsvgr_opacity', 09:59:38 INFO - 'tart', 09:59:38 INFO - 'tscrollx', 09:59:38 INFO - 'cart']}, 09:59:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:59:38 INFO - 'tsvgr_opacity', 09:59:38 INFO - 'tart', 09:59:38 INFO - 'tscrollx', 09:59:38 INFO - 'cart']}, 09:59:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'talos_options': ['--disable-e10s'], 09:59:38 INFO - 'tests': ['tp5o']}, 09:59:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'tests': ['tp5o']}, 09:59:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'talos_options': ['--disable-e10s', 09:59:38 INFO - '--xperf_path', 09:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:38 INFO - 'tests': ['tp5n']}, 09:59:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:38 INFO - 'talos_options': ['--xperf_path', 09:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:38 INFO - 'tests': ['tp5n']}}, 09:59:38 INFO - 'talos.zip': {'path': '', 09:59:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:59:38 INFO - Running post-action listener: _resource_record_post_action 09:59:38 INFO - [mozharness: 2017-01-31 17:59:38.198467Z] Finished populate-webroot step (success) 09:59:38 INFO - [mozharness: 2017-01-31 17:59:38.198583Z] Running create-virtualenv step. 09:59:38 INFO - Running pre-action listener: _resource_record_pre_action 09:59:38 INFO - Running main action method: create_virtualenv 09:59:38 INFO - Creating virtualenv /builds/slave/test/build/venv 09:59:38 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 09:59:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:59:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:59:38 INFO - Using real prefix '/tools/python27' 09:59:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:59:39 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:41 INFO - Installing pip.................done. 09:59:41 INFO - Return code: 0 09:59:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:59:42 INFO - Reading from file tmpfile_stdout 09:59:42 INFO - Output received: 09:59:42 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) 09:59:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:59:42 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')]} 09:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:42 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')]} 09:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:42 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 0x1093d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10934a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a34a6050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, '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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 09:59:42 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 09:59:42 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 09:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 09:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:42 INFO - 'HOME': '/Users/cltbld', 09:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:42 INFO - 'LOGNAME': 'cltbld', 09:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:42 INFO - 'MOZ_NO_REMOTE': '1', 09:59:42 INFO - 'NO_EM_RESTART': '1', 09:59:42 INFO - 'PAGER': '/bin/cat', 09:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:42 INFO - 'PWD': '/builds/slave/test', 09:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:42 INFO - 'SHELL': '/bin/bash', 09:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 09:59:42 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:42 INFO - 'USER': 'cltbld', 09:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:42 INFO - 'XPC_FLAGS': '0x0', 09:59:42 INFO - 'XPC_SERVICE_NAME': '0', 09:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:42 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 09:59:42 INFO - Cleaning up... 09:59:42 INFO - Return code: 0 09:59:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:59:42 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')]} 09:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:42 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')]} 09:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:42 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 0x1093d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10934a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a34a6050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, '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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 09:59:42 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 09:59:42 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 09:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 09:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:42 INFO - 'HOME': '/Users/cltbld', 09:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:42 INFO - 'LOGNAME': 'cltbld', 09:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:42 INFO - 'MOZ_NO_REMOTE': '1', 09:59:42 INFO - 'NO_EM_RESTART': '1', 09:59:42 INFO - 'PAGER': '/bin/cat', 09:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:42 INFO - 'PWD': '/builds/slave/test', 09:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:42 INFO - 'SHELL': '/bin/bash', 09:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 09:59:42 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:42 INFO - 'USER': 'cltbld', 09:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:42 INFO - 'XPC_FLAGS': '0x0', 09:59:42 INFO - 'XPC_SERVICE_NAME': '0', 09:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:42 INFO - Downloading/unpacking psutil>=3.1.1 09:59:42 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 09:59:42 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 09:59:42 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 09:59:42 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 09:59:42 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 09:59:42 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 09:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:46 INFO - Installing collected packages: psutil 09:59:46 INFO - Running setup.py install for psutil 09:59:46 INFO - building 'psutil._psutil_osx' extension 09:59:46 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 09:59:46 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 09:59:46 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 09:59:46 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 09:59:46 INFO - building 'psutil._psutil_posix' extension 09:59:46 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 09:59:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:59:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:59:46 INFO - ^ 09:59:46 INFO - 1 warning generated. 09:59:46 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 09:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:47 INFO - Successfully installed psutil 09:59:47 INFO - Cleaning up... 09:59:47 INFO - Return code: 0 09:59:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:59:47 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')]} 09:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:47 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')]} 09:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:47 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 0x1093d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10934a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a34a6050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, '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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 09:59:47 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 09:59:47 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 09:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 09:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:47 INFO - 'HOME': '/Users/cltbld', 09:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:47 INFO - 'LOGNAME': 'cltbld', 09:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:47 INFO - 'MOZ_NO_REMOTE': '1', 09:59:47 INFO - 'NO_EM_RESTART': '1', 09:59:47 INFO - 'PAGER': '/bin/cat', 09:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:47 INFO - 'PWD': '/builds/slave/test', 09:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:47 INFO - 'SHELL': '/bin/bash', 09:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 09:59:47 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:47 INFO - 'USER': 'cltbld', 09:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:47 INFO - 'XPC_FLAGS': '0x0', 09:59:47 INFO - 'XPC_SERVICE_NAME': '0', 09:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:59:47 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 09:59:47 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 09:59:47 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 09:59:47 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 09:59:47 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 09:59:47 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 09:59:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:59:50 INFO - Installing collected packages: mozsystemmonitor 09:59:50 INFO - Running setup.py install for mozsystemmonitor 09:59:50 INFO - Successfully installed mozsystemmonitor 09:59:50 INFO - Cleaning up... 09:59:50 INFO - Return code: 0 09:59:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:59:50 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')]} 09:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:50 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')]} 09:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:50 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 0x1093d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10934a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a34a6050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, '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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 09:59:50 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 09:59:50 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 09:59:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 09:59:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:50 INFO - 'HOME': '/Users/cltbld', 09:59:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:50 INFO - 'LOGNAME': 'cltbld', 09:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:50 INFO - 'MOZ_NO_REMOTE': '1', 09:59:50 INFO - 'NO_EM_RESTART': '1', 09:59:50 INFO - 'PAGER': '/bin/cat', 09:59:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:50 INFO - 'PWD': '/builds/slave/test', 09:59:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:50 INFO - 'SHELL': '/bin/bash', 09:59:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 09:59:50 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:59:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:50 INFO - 'USER': 'cltbld', 09:59:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:50 INFO - 'XPC_FLAGS': '0x0', 09:59:50 INFO - 'XPC_SERVICE_NAME': '0', 09:59:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:50 INFO - Downloading/unpacking jsonschema==2.5.1 09:59:50 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 09:59:50 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 09:59:50 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 09:59:50 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 09:59:50 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 09:59:50 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 09:59:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:59:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:59:53 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 09:59:53 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 09:59:53 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 09:59:53 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 09:59:53 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 09:59:53 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 09:59:53 INFO - Downloading functools32-3.2.3-2.tar.gz 09:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:59:53 INFO - warning: no files found matching '*.txt' 09:59:53 INFO - no previously-included directories found matching 'build' 09:59:53 INFO - no previously-included directories found matching 'dist' 09:59:53 INFO - no previously-included directories found matching '.git*' 09:59:53 INFO - Installing collected packages: jsonschema, functools32 09:59:53 INFO - Running setup.py install for functools32 09:59:53 INFO - warning: no files found matching '*.txt' 09:59:53 INFO - no previously-included directories found matching 'build' 09:59:53 INFO - no previously-included directories found matching 'dist' 09:59:53 INFO - no previously-included directories found matching '.git*' 09:59:53 INFO - Successfully installed jsonschema functools32 09:59:53 INFO - Cleaning up... 09:59:54 INFO - Return code: 0 09:59:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:59: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')]} 09:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59: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')]} 09:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:54 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 0x1093d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10934a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a34a6050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, '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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 09:59:54 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 09:59:54 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 09:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 09:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:54 INFO - 'HOME': '/Users/cltbld', 09:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:54 INFO - 'LOGNAME': 'cltbld', 09:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:54 INFO - 'MOZ_NO_REMOTE': '1', 09:59:54 INFO - 'NO_EM_RESTART': '1', 09:59:54 INFO - 'PAGER': '/bin/cat', 09:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:54 INFO - 'PWD': '/builds/slave/test', 09:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:54 INFO - 'SHELL': '/bin/bash', 09:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 09:59:54 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:54 INFO - 'USER': 'cltbld', 09:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:54 INFO - 'XPC_FLAGS': '0x0', 09:59:54 INFO - 'XPC_SERVICE_NAME': '0', 09:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:59:54 INFO - Cleaning up... 09:59:54 INFO - Return code: 0 09:59:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:59: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')]} 09:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59: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')]} 09:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:54 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 0x1093d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10934a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a34a6050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, '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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 09:59:54 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 09:59:54 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 09:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 09:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:54 INFO - 'HOME': '/Users/cltbld', 09:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:54 INFO - 'LOGNAME': 'cltbld', 09:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:54 INFO - 'MOZ_NO_REMOTE': '1', 09:59:54 INFO - 'NO_EM_RESTART': '1', 09:59:54 INFO - 'PAGER': '/bin/cat', 09:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:54 INFO - 'PWD': '/builds/slave/test', 09:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:54 INFO - 'SHELL': '/bin/bash', 09:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 09:59:54 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:54 INFO - 'USER': 'cltbld', 09:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:54 INFO - 'XPC_FLAGS': '0x0', 09:59:54 INFO - 'XPC_SERVICE_NAME': '0', 09:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:59:54 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 09:59:54 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 09:59:54 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 09:59:54 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 09:59:54 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 09:59:54 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 09:59:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59:57 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 09:59:57 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 09:59:57 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 09:59:57 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 09:59:57 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 09:59:57 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 09:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:57 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 09:59:57 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 09:59:57 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 09:59:57 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 09:59:57 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 09:59:57 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 09:59:58 INFO - Downloading docopt-0.6.1.tar.gz 09:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:58 INFO - Running setup.py install for blobuploader 09:59:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:58 INFO - Running setup.py install for requests 09:59:59 INFO - Running setup.py install for docopt 09:59:59 INFO - Successfully installed blobuploader requests docopt 09:59:59 INFO - Cleaning up... 09:59:59 INFO - Return code: 0 09:59:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:59 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')]} 09:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:59 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')]} 09:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:59 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 0x1093d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10934a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a34a6050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, '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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 09:59:59 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 09:59:59 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 09:59:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 09:59:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:59 INFO - 'HOME': '/Users/cltbld', 09:59:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:59 INFO - 'LOGNAME': 'cltbld', 09:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:59 INFO - 'MOZ_NO_REMOTE': '1', 09:59:59 INFO - 'NO_EM_RESTART': '1', 09:59:59 INFO - 'PAGER': '/bin/cat', 09:59:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:59 INFO - 'PWD': '/builds/slave/test', 09:59:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:59 INFO - 'SHELL': '/bin/bash', 09:59:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 09:59:59 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 09:59:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:59 INFO - 'USER': 'cltbld', 09:59:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:59 INFO - 'XPC_FLAGS': '0x0', 09:59:59 INFO - 'XPC_SERVICE_NAME': '0', 09:59:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:59 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-lUIODo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:59 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-IZkD78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:59 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-730MFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:59 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-pu3cg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:00 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-JFZe7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:00 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-LMUSF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:00 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-hXog0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:00 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Rc_5pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:00 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-yjkHd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:00 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-oz2_ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:00 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-AWazhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:00 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-h3O2A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:00 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ufNXMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:01 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-gdBfi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:01 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-zud_Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:01 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-9nsnPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:01 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-gIkSQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:01 INFO - Running setup.py install for manifestparser 10:00:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:01 INFO - Running setup.py install for mozcrash 10:00:01 INFO - Running setup.py install for mozdebug 10:00:01 INFO - Running setup.py install for mozdevice 10:00:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Running setup.py install for mozfile 10:00:02 INFO - Running setup.py install for mozhttpd 10:00:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Running setup.py install for mozinfo 10:00:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Running setup.py install for mozInstall 10:00:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Running setup.py install for mozleak 10:00:02 INFO - Running setup.py install for mozlog 10:00:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:02 INFO - Running setup.py install for moznetwork 10:00:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:03 INFO - Running setup.py install for mozprocess 10:00:03 INFO - Running setup.py install for mozprofile 10:00:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:03 INFO - Running setup.py install for mozrunner 10:00:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:03 INFO - Running setup.py install for mozscreenshot 10:00:03 INFO - Running setup.py install for moztest 10:00:03 INFO - Running setup.py install for mozversion 10:00:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:03 INFO - Cleaning up... 10:00:04 INFO - Return code: 0 10:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:04 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')]} 10:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:04 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')]} 10:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:04 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 0x1093d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10934a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a34a6050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, '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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:00:04 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 10:00:04 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 10:00:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 10:00:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:04 INFO - 'HOME': '/Users/cltbld', 10:00:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:04 INFO - 'LOGNAME': 'cltbld', 10:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:04 INFO - 'MOZ_NO_REMOTE': '1', 10:00:04 INFO - 'NO_EM_RESTART': '1', 10:00:04 INFO - 'PAGER': '/bin/cat', 10:00:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:04 INFO - 'PWD': '/builds/slave/test', 10:00:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:04 INFO - 'SHELL': '/bin/bash', 10:00:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 10:00:04 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:00:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:04 INFO - 'USER': 'cltbld', 10:00:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:04 INFO - 'XPC_FLAGS': '0x0', 10:00:04 INFO - 'XPC_SERVICE_NAME': '0', 10:00:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:04 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-OE1zif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:04 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-GIZKfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:04 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-koVl8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:04 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Kk8XRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:04 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-yBD9Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:04 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-6tAafK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:04 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)) 10:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:04 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ylmfHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:05 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)) 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ceXUdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:05 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)) 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-lIf6dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:05 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)) 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-trWntH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:05 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)) 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-0YzOd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:05 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)) 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-UZpHoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:05 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)) 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-nKf9vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:05 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)) 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-13h1PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:05 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)) 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-eT6rqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:05 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)) 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-6tQalK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:05 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)) 10:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-oRrb_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:06 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)) 10:00:06 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)) 10:00:06 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)) 10:00:06 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)) 10:00:06 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)) 10:00:06 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)) 10:00:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:06 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 10:00:06 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 10:00:06 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 10:00:06 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 10:00:06 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 10:00:06 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 10:00:08 INFO - Downloading blessings-1.6.tar.gz 10:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:08 INFO - Installing collected packages: blessings 10:00:08 INFO - Running setup.py install for blessings 10:00:08 INFO - Successfully installed blessings 10:00:08 INFO - Cleaning up... 10:00:09 INFO - Return code: 0 10:00:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:09 INFO - Reading from file tmpfile_stdout 10:00:09 INFO - Current package versions: 10:00:09 INFO - blessings == 1.6 10:00:09 INFO - blobuploader == 1.2.4 10:00:09 INFO - docopt == 0.6.1 10:00:09 INFO - functools32 == 3.2.3-2 10:00:09 INFO - jsonschema == 2.5.1 10:00:09 INFO - manifestparser == 1.1 10:00:09 INFO - mozInstall == 1.12 10:00:09 INFO - mozcrash == 1.0 10:00:09 INFO - mozdebug == 0.1 10:00:09 INFO - mozdevice == 0.48 10:00:09 INFO - mozfile == 1.2 10:00:09 INFO - mozhttpd == 0.7 10:00:09 INFO - mozinfo == 0.9 10:00:09 INFO - mozleak == 0.1 10:00:09 INFO - mozlog == 3.4 10:00:09 INFO - moznetwork == 0.27 10:00:09 INFO - mozprocess == 0.23 10:00:09 INFO - mozprofile == 0.28 10:00:09 INFO - mozrunner == 6.13 10:00:09 INFO - mozscreenshot == 0.1 10:00:09 INFO - mozsystemmonitor == 0.3 10:00:09 INFO - moztest == 0.8 10:00:09 INFO - mozversion == 1.4 10:00:09 INFO - psutil == 3.1.1 10:00:09 INFO - requests == 1.2.3 10:00:09 INFO - wsgiref == 0.1.2 10:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:09 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')]} 10:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:09 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')]} 10:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:10 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 0x1093d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10934a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a34a6050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, '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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:00:10 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 10:00:10 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 10:00:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 10:00:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:10 INFO - 'HOME': '/Users/cltbld', 10:00:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:10 INFO - 'LOGNAME': 'cltbld', 10:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:10 INFO - 'MOZ_NO_REMOTE': '1', 10:00:10 INFO - 'NO_EM_RESTART': '1', 10:00:10 INFO - 'PAGER': '/bin/cat', 10:00:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:10 INFO - 'PWD': '/builds/slave/test', 10:00:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:10 INFO - 'SHELL': '/bin/bash', 10:00:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 10:00:10 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:00:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:10 INFO - 'USER': 'cltbld', 10:00:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:10 INFO - 'XPC_FLAGS': '0x0', 10:00:10 INFO - 'XPC_SERVICE_NAME': '0', 10:00:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:10 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)) 10:00:10 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)) 10:00:10 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)) 10:00:10 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)) 10:00:10 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)) 10:00:10 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)) 10:00:10 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)) 10:00:10 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)) 10:00:10 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)) 10:00:10 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)) 10:00:10 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)) 10:00:10 INFO - Cleaning up... 10:00:10 INFO - Return code: 0 10:00:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093d4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10934a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7a34a6050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, '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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 10:00: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'] in /builds/slave/test/build 10:00: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 10:00:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 10:00:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:10 INFO - 'HOME': '/Users/cltbld', 10:00:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:10 INFO - 'LOGNAME': 'cltbld', 10:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:10 INFO - 'MOZ_NO_REMOTE': '1', 10:00:10 INFO - 'NO_EM_RESTART': '1', 10:00:10 INFO - 'PAGER': '/bin/cat', 10:00:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:10 INFO - 'PWD': '/builds/slave/test', 10:00:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:10 INFO - 'SHELL': '/bin/bash', 10:00:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 10:00:10 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:00:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:10 INFO - 'USER': 'cltbld', 10:00:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:10 INFO - 'XPC_FLAGS': '0x0', 10:00:10 INFO - 'XPC_SERVICE_NAME': '0', 10:00:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:00:11 INFO - Cleaning up... 10:00:11 INFO - Return code: 0 10:00:11 INFO - Running post-action listener: _resource_record_post_action 10:00:11 INFO - Running post-action listener: _start_resource_monitoring 10:00:11 INFO - Starting resource monitoring. 10:00:11 INFO - [mozharness: 2017-01-31 18:00:11.159450Z] Finished create-virtualenv step (success) 10:00:11 INFO - [mozharness: 2017-01-31 18:00:11.160447Z] Running install step. 10:00:11 INFO - Running pre-action listener: _resource_record_pre_action 10:00:11 INFO - Running main action method: install 10:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:11 INFO - Reading from file tmpfile_stdout 10:00:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:11 INFO - Reading from file tmpfile_stdout 10:00:11 INFO - Output received: 10:00:11 INFO - Usage: mozinstall [options] installer 10:00:11 INFO - Options: 10:00:11 INFO - -h, --help show this help message and exit 10:00:11 INFO - -d DEST, --destination=DEST 10:00:11 INFO - Directory to install application into. [default: 10:00:11 INFO - "/builds/slave/test"] 10:00:11 INFO - --app=APP Application being installed. [default: firefox] 10:00:11 INFO - mkdir: /builds/slave/test/build/application 10:00:11 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'] 10:00:11 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 10:00:32 INFO - Reading from file tmpfile_stdout 10:00:32 INFO - Output received: 10:00:32 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:00:32 INFO - Running post-action listener: _resource_record_post_action 10:00:32 INFO - [mozharness: 2017-01-31 18:00:32.499423Z] Finished install step (success) 10:00:32 INFO - [mozharness: 2017-01-31 18:00:32.499572Z] Running run-tests step. 10:00:32 INFO - Running pre-action listener: _resource_record_pre_action 10:00:32 INFO - Running main action method: run_tests 10:00:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:00:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:00:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:00:32 INFO - 2017-01-31 10:00:32.514 screenresolution[1891:12405] starting screenresolution argv=screenresolution get 10:00:32 INFO - 2017-01-31 10:00:32.516 screenresolution[1891:12405] Display 0: 1600x1200x32@60 10:00:32 INFO - 2017-01-31 10:00:32.522 screenresolution[1892:12407] starting screenresolution argv=screenresolution list 10:00:32 INFO - Available Modes on Display 0 10:00:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:00:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:00:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:00:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:00:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:00:32 INFO - Intel Iris: 10:00:32 INFO - Chipset Model: Intel Iris 10:00:32 INFO - Type: GPU 10:00:32 INFO - Bus: Built-In 10:00:32 INFO - VRAM (Dynamic, Max): 1536 MB 10:00:32 INFO - Vendor: Intel (0x8086) 10:00:32 INFO - Device ID: 0x0a2e 10:00:32 INFO - Revision ID: 0x0009 10:00:32 INFO - Displays: 10:00:32 INFO - Display: 10:00:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:00:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:00:32 INFO - Display Serial Number: 1600x1200 60 10:00:32 INFO - Main Display: Yes 10:00:32 INFO - Mirror: Off 10:00:32 INFO - Online: Yes 10:00:32 INFO - Rotation: Supported 10:00:32 INFO - Return code: 0 10:00:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:32 INFO - Python 2.7.3 10:00:32 INFO - Return code: 0 10:00:32 INFO - grabbing minidump binary from tooltool 10:00:32 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')]} 10:00:32 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 0x1091e8d30>, '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 0x10904edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:32 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 10:00:32 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 10:00:32 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 10:00:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:32 INFO - Return code: 0 10:00:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:00:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:00:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:32 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/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 10:00:32 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/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --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 10:00:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EBOfNR9xuc/Render', 10:00:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:32 INFO - 'HOME': '/Users/cltbld', 10:00:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:32 INFO - 'LOGNAME': 'cltbld', 10:00:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:32 INFO - 'MOZ_NO_REMOTE': '1', 10:00:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:32 INFO - 'NO_EM_RESTART': '1', 10:00:32 INFO - 'PAGER': '/bin/cat', 10:00:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:32 INFO - 'PWD': '/builds/slave/test', 10:00:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:32 INFO - 'SHELL': '/bin/bash', 10:00:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4RHCIXWJJ/Listeners', 10:00:32 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 10:00:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:32 INFO - 'USER': 'cltbld', 10:00:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:32 INFO - 'XPC_FLAGS': '0x0', 10:00:32 INFO - 'XPC_SERVICE_NAME': '0', 10:00:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:32 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/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 10:00:33 INFO - mozversion application_buildid: 20170131074809 10:00:33 INFO - mozversion application_changeset: d859990cc3113332b24cc0088c8d75fbe5471775 10:00:33 INFO - mozversion application_display_name: Firefox 10:00:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:33 INFO - mozversion application_name: Firefox 10:00:33 INFO - mozversion application_remotingname: firefox 10:00:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:00:33 INFO - mozversion application_vendor: Mozilla 10:00:33 INFO - mozversion application_version: 52.0 10:00:33 INFO - mozversion platform_buildid: 20170131074809 10:00:33 INFO - mozversion platform_changeset: d859990cc3113332b24cc0088c8d75fbe5471775 10:00:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:00:33 INFO - mozversion platform_version: 52.0 10:00:33 INFO - using testdate: 1485885633 10:00:33 INFO - actual date: 1485885633 10:00:33 INFO - starting webserver on 'localhost:51535' 10:00:33 INFO - SUITE-START | Running 2 tests 10:00:33 INFO - TEST-START | dromaeo_css 10:00:33 INFO - operating with platform_type : mac_ 10:00:33 INFO - Initialising browser for dromaeo_css test... 10:00:33 INFO - TEST-INFO | started process 1902 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmp5VQuow/profile http://localhost:51535/getInfo.html) 10:00:35 INFO - PROCESS | 1902 | __metrics Screen width/height:1600/1200 10:00:35 INFO - PROCESS | 1902 | colorDepth:24 10:00:35 INFO - PROCESS | 1902 | Browser inner width/height: 1024/689 10:00:35 INFO - PROCESS | 1902 | __metrics 10:00:35 INFO - PROCESS | 1902 | 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" 10:00:35 INFO - PROCESS | 1902 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:00:36 INFO - TEST-INFO | 1902: exit 0 10:00:36 INFO - Browser initialized. 10:00:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:36 INFO - TEST-INFO | started process 1905 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmp5VQuow/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:48 INFO - PROCESS | 1905 | RSS: Main: 171859968 10:00:48 INFO - PROCESS | 1905 | 10:03:51 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51535/tests/dromaeo/cssquery-ext.html) 10:03:53 INFO - PROCESS | 1905 | RSS: Main: 325545984 10:03:53 INFO - PROCESS | 1905 | 10:06:55 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-ext.html (next: http://localhost:51535/tests/dromaeo/cssquery-jquery.html) 10:06:56 INFO - PROCESS | 1905 | RSS: Main: 299167744 10:06:56 INFO - PROCESS | 1905 | 10:09:58 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51535/tests/dromaeo/cssquery-mootools.html) 10:09:59 INFO - PROCESS | 1905 | RSS: Main: 277741568 10:09:59 INFO - PROCESS | 1905 | 10:13:01 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51535/tests/dromaeo/cssquery-prototype.html) 10:13:02 INFO - PROCESS | 1905 | RSS: Main: 268652544 10:13:02 INFO - PROCESS | 1905 | 10:16:05 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51535/tests/dromaeo/cssquery-yui.html) 10:16:06 INFO - PROCESS | 1905 | RSS: Main: 258125824 10:16:06 INFO - PROCESS | 1905 | 10:19:09 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51535/tests/dromaeo/cssquery-yui.html (next: http://localhost:51535/tests/dromaeo/cssquery-dojo.html) 10:19:09 INFO - PROCESS | 1905 | RSS: Main: 304353280 10:19:09 INFO - PROCESS | 1905 | 10:19:09 INFO - PROCESS | 1905 | __start_tp_report 10:19:09 INFO - PROCESS | 1905 | _x_x_mozilla_page_load 10:19:09 INFO - PROCESS | 1905 | _x_x_mozilla_page_load_details 10:19:09 INFO - PROCESS | 1905 | |i|pagename|runs| 10:19:09 INFO - PROCESS | 1905 | |0;dojo.html;3400.778949368291;3403.829808509577;3418.230898047939;3428.48572714093;3483.320752453271;5771.134329850524;5784.161296611988;5789.507891829189;5815.767369305228;5828.067509198524;5732.856678583037;5799.710014499279;5817.796377126801;5829.766809327622;5841.123831425289;5202;5210.713410762407;5249.1601343785005;5273.789048438077;5334.146536554152;5124.128898087315;5136.126858434057;5142.948570514284;5345.599080068991;5364.463553644624;5187.896242075156;5264.526192642661;5297.867553311159;5299.33758280215;5309.0709125903;5285.154375299952;5331.893362132736;5337.386200586943;5347.919781203285;5390;5052.494750524955;5161.225816127573;5236.21456781482;5269.262303277545;5281.498257665554;5689.402612725687;5734.942650573483;5741.33974592923;5751.281089863767;5754.769809207627;6214.627122372627;6256.812295631093;6257.030160325156;6275.435210831047;6281.748730050793;6296.96851515744;6300.495960323163;6310;6310.368963103699;6316.621002739805;5686.943130568683;5737.655740655616;5742.511886489611;5789.623674461147;5818.883622327529;6229.4393504583895;6241.407066328691;6268.780592679325;6276.278228003746;6292.433680968643;5993.730282137314;6151.053846652444;6165.352637972948;6182.598131121463;6196.47329976948;6125.876495711566;6164.352742961924;6250.062490626351;6254.437100660963;6284.340144284875;6224.502039836802;6229.595076320115;6239.875202495925;6241.095041218998;6247.843803904848;6192.225971753531;6259.061140828912;6271.9686401568615;6272.5922815016875;6273.749050037947;4854.563089321978;4926.926096108561;4928.457869634337;4932.753362331869;4959.652824302337;4496.730196188174;4506.278995360726;4518.774061296987;4533.52397998212;4574.83988060423;4933.161362568372;5705.2012718219485;5729.713514324267;5818.301803783573;5842.737076831553;6120.416658367975;6139;6224.439800417984;6267.185265915493;6278.560500764903;5020.272060551272;5417.83746487606;5809.157672137517;5840.941590584125;5874.060150375919;5396.676199428047;5419.972900135553;5434.755436005389;5441.183822426668;5445.782168713286;6192.690365481798;6247.468965138014;6329.778457753957;6332.430081292706;6358.7456501740335;6151.815445536641;6207.472364849038;6215.378462153929;6227.9377206227355;6244;6267.467265282502;6369.33122022181;6377.1390862233;6381.329960354096;6396.9040464394;6148.047052706837;6164.167837342081;6209.037599172136;6225.066240063846;6225.968870155621;6108.4807791338235;6138.602983405075;6190.2571691397325;6272.310045895039;6299.590526615755;6023.066424704178;6108.8778224436155;6175.6912154393;6180.721867516063;6187.876242475035;6099.268087829311;6159.938400615936;6161.815145545641;6163.907541386793;6169.691515424301;4752.239641657318;5875.559333049953;6021.946159421996;6056.454919057306;6083.209182806207;6096.268447786294;6110.8929201734545;6119.999800813725;6160.815175544741;6165.506759459322;5839.678817664899;5893.233879595625;5903.380145084704;6030.30651475086;6056.727447264796 10:19:09 INFO - PROCESS | 1905 | |1;ext.html;463.7472577445292;478.68646036845854;505.15891041416046;524.3236225269401;526.1686535274267;32409;40179.19641607166;40635.59364406355;40676.18647627046;40715;43578.78210608943;44452.555474445326;44995.77502112485;45035.324470132975;45062.54937450625;8938.910610893905;9624.085711857362;9809;9812.411255324703;9814.018598140201;8931.821363572724;11904.464299106561;12191.451384687665;12201.389930503483;12203;11963;12056.457459414347;12063.396830158501;12066.638000859988;12067.974222191124;12007.699807504838;12064;12066.396680165957;12080.456379462901;12084.879151208463;11731.7067073323;11804.232724872942;11812.40937953099;11832.053435725207;11835.526578936831;41481;41692.37461438081;41757.37363939543;41813.163736725095;41829.58170418287;3325.0042309185505;3522.7710198836994;3719.4606782016726;3815.5993620669983;4060.9187816243807;28258;29059;29095.854520727262;29673;31136.68863311383;3264.657210992835;3352.4133276676484;3413.044347582681;3435.8282085895853;3454.9827250863586;503539;504993;505204;506642.46678766736;506911;47457.762711186224;58881.70559147262;61930.69034654798;62261;62557;65722.67138664372;65755;65812.34187658157;65875.67062164658;66056.00915986265;16616.25226864794;17025.40411085606;17030.57423564396;17046;17053.48839534816;11563.826542601868;11814.46834892432;12919.901808346207;13164.40760165795;13167.539136130381;12412.317322547347;14237.64405889861;14860;14861.405543778345;14999.95000349987;5755.309362876482;5790.42095790426;6170;6412.807615771534;6526.118973938553;827.7914245202072;873.6025108575583;1009.9848502272472;1046.424466543398;1073.2272763610188;30476.390472190433;30625.9280925171;30779;31074.53388199179;31119.377612448076;1011.2718842433436;1071.132382769959;1099.9285046472114;1122.7249323915694;1141.6004398460639;15584.350660387761;15846;15893.284802183929;16107.194640268173;16314.83685163157;191086.04456977625;191190;191757;192195;192271.03864480587;51105.233421498706;51897.962040758975;58872.7056364724;60018.799624007275;60021.399786002454;1390.8539603341503;1425.0879437160227;1435.7056803355497;1439.805626240444;1442.0986883198002;28381;28422.289442764097;31043;31241.906533271227;32031.35937281288;52045.7397713009;52652.47347526476;52675.736621316646;52723.20915186352;52737.20894186514;582794;589938;589964;590048;590963.0451847713;40325.1934961305;40941.18117637571;41179;41206.38190427206;41667;47885.04229915452;48858.77853053702;48914.75542622264;49251.76870578264;49479.50520494749;35725;39488.80255598704;39620.603793961694;40356.789296321156;40394;32897.67102328946;39415;40007.79996100001;40148.39777403283;40458.39312410375;38792.418113727756;38958.80520597379;39549.60450395574;39650.60349396469;39967.80016099901;28315.433691325645;34386.968390948314;35368.823155884056;35409.29181416306;35649.643503564635;22253;26214.344641383355;26420;26522.204333870013;26535.187358014366 10:19:09 INFO - PROCESS | 1905 | |2;jquery.html;393.307778310174;396.2629509113049;401.0835241473233;401.3458063356728;415.2048826497258;20237.59524809503;20414.69377959332;21011;21374.251901183463;21432.35702928911;20307.898460507713;20404.489887752814;20983.73423598838;21305.36083917485;21552.89223553884;5538.75075621596;5907;6224.0663900415075;6287.528435367343;6305.842353941142;5974.761009559634;6104.114903339013;6173.290071641752;6226.595271307373;6237.968810155966;6215.508278013267;6218.626882387049;6218.657973811439;6218.937810621904;6222.12890195373;6052.152698622196;6061.969690151565;6127.4791642710425;6131.417515336036;6202.534809889254;5383.327084114486;5383.676979381211;5384.40771515133;5386.245925570423;5391.838244852622;26743.73256267432;26809.19572412831;26991.73008269912;27000.05499807517;27261.318467038283;2311.2257393773107;2451.8161137914726;2539.7935980409343;2796.2869468285458;2800.3979144484033;15842.28709708066;16065.839341606552;16092.919535402365;16383;16789.328426863034;1858.1452531835373;1892.0728842867034;1902.4197619725978;1927.267638297452;1957.4812674641232;102982;118136.40931795286;123038;125428;131066;10976.615818446477;10996.560137594566;11507.424628768527;11525.135614828921;11769.705757355963;14468.204248766418;14506.274686265644;14512.346944387527;14536.85463145355;14550.417983280762;8035.7991050223045;8737.650493980169;8756.474611523328;8874.624433212863;8875.955620221986;8715.477071375737;8740.169683880022;8762.956185219033;8874.467531948103;8898.644054237759;5646.915296270559;6754.966225168941;6897;6897.310268973062;6918.757843475454;1435.167602790379;1916.338863092231;1939.767227932657;1943.805619438045;1970.9014549272479;788.2393490281905;799.6441583495405;875.6497401039635;991.6727479931606;1077.2190162132392;21938.89030554837;22742.772572274065;22907.31278061661;23007;23039.308820735405;984.9753756156153;1007.8639383683255;1030.6135199300263;1037.273908264218;1067.4769363012224;11822.34977076252;12025.518979240733;12261;12273.631791046282;12278.386080696107;612327;618475;620284;630049;630191;121568.78431215751;123338;127766;127947;133858.33070834583;1039.2984735303792;1045.628801775374;1049.7847941172195;1068.1294744782977;1070.8286674132257;18851.340203093376;19420.028998550297;19956.401307960783;20042.39872803818;20052.498687532927;34432;43990.12019759651;44395.89010274769;51588.968220634626;53010;70755.64622176856;71686;80447.7820887158;81226;86188.70716939126;7675.808104797425;8218.383621228551;8347.248747612744;8468.957655211685;8501.447405918596;9447.527623618655;12886.420111094836;13642.386092625657;13715.039947203999;13776.24230667323;11315.377654229096;11361.147913906325;11649.883501165219;11835.822462662894;11979.700507487383;11211.887881121085;11317.943410282896;11327.093832493216;11667.416629168678;11796.351200684045;11088.944555277172;11374.601888933848;11529.135314851588;11817.527298907948;11993.280403175837;8330.250277475056;8394.160583941557;8594.097619749837;8640.395172337876;8829.602667879832;9743.366681165702;9993.950030249802;11529.558805149356;11799.93800557954;11951.103667225167 10:19:09 INFO - PROCESS | 1905 | |3;mootools.html;1371.5336785492934;1513.5988962924828;1675.849173574378;1838.485224137242;1856.3038860427332;6623.635700036496;8565.057843637194;8565.700200492984;8570.842936203626;8573.957130214356;7559.319661230488;7772.067351917778;7780.533168009923;7857.6856925722905;8389.454685445442;2152.2251989283886;2186.890655467228;2308.9422764430856;2382.5949588569983;2383.1778036577352;2415.9637605435933;2426.6360045993065;2426.7815896569305;2427.174760581402;2428.1622840120217;1964.7445832041815;2400.291913885408;2400.4238982644215;2401.399650087478;2402.543516731824;2364.207990323244;2374.085976898889;2393.940151496209;2402;2403.170906037414;2392.605220138675;2394.844335118212;2414.6619473273754;2421.3220298316323;2425.236050644059;8376.916230837674;8554.743357699217;8557.957210213908;8563.229309362125;8569;5164.741762911877;5319.7340132993195;5321.068812957756;5322.308099947021;5324.866878328034;3326.800391976489;3546.060294022086;3589.3898037333456;3594.101474631342;3624.6194149614175;1037.190991027;1069.8823129455754;1110.1562812262657;1124.3534967393782;1127.4813585750564;11083.556657733761;11122.55509779608;11129.443527823576;11135.276207046516;11145.498452569655;4440.822367105344;4540.250858608359;4669.883252918704;4672.299155126758;4755.548222918817;8803.955980220186;8866.980297265767;8869.201771840566;8870.024297327289;8892.288616910631;5077.060743762416;5082.847514574495;5086.898262034739;5089.160288552347;5089.982003599295;4631.467381251132;4775.808967641256;4779.904401912012;4810;4877.146499362598;3323.9031119730917;3475.669811367916;3605.8737944171826;3627.6372362763514;3849.268638958589;994.8060128275062;1158.8783177766213;1177.7350096228452;1177.7585594953014;1190.2382475215868;816.506013861617;888.968796196409;894.852349362361;897.9449147252084;932.9860052099224;5307.363116426053;5655.179998900218;5841.328247251536;5884.882302353929;6015.699215039231;821.7904434369198;962.43216502264;964.9228061755043;965.2712202287228;1011.0900189829213;3912.980435097806;3946.723729338919;3947.822347994347;3987.501562304712;4099.139180772071;9886.901130988743;10340.948295258626;10342.689719308433;10347.896521034843;10360.689179324632;9848.655297064568;10271.332363396356;10294.948525257476;10301.742456438498;10301.896981030093;7791.298783109547;8113.148119447373;8120.796980075427;8125.796855078552;8148.185181481805;4448.510663827041;5778.913316300175;5833.766649333979;5956.987312157031;6143.56995010345;9306.441613503212;9585.472798996123;9606.471644059644;9692.660756873476;9731.464769437749;8315.875261870955;9339.813203735752;9593.904060959301;9808.313418060952;9853.261005424765;6248.468880145057;7251.564906105439;7325.194228634739;7451.143118541437;7480.887786683313;7316.451266154953;7589.468737188344;7867.095284042409;8118.83762324762;8129.9187008129165;7315.414766818535;7339.082614673166;7342.265773422615;7342.3758980487255;7499.550026998398;7187.101612298463;7196;7201.81995450097;7211.314925082109;7241.456890733321;6752.3922846944015;6831.316868313129;6890.10428644273;6897.655117244218;6900.171979362509;4764.690295130806;4868.683535570177;4871.269309603446;4908.460069392436;4913.950860491493;4263.232618128766;4871.951280487291;4908.410990681141;5035.597152227886;5076.010178015252 10:19:09 INFO - PROCESS | 1905 | |4;prototype.html;259.5224786393037;272.4224643755239;314.1831238779173;321.5771260792058;327.9426100432424;4954.355933728611;5060.519250671189;5248.7927776611405;5269.78543088716;5293.206019097132;4074.1666250187386;5124.282600435942;5181.481851814817;5205.869853253671;5238.711870847102;3046.588710524073;3202.67973202679;3517.6306487818792;4042.3532234842432;4057.4319595256616;3660.9566273612027;3768.3593789055926;4004.619561141687;4025.859094931678;4060.817263223162;3571.0358203285095;3612.3858943979585;3689.538807649044;4000.639942405183;4041.939370909439;3982.3429134192825;3985.2066570043307;3989.1822176453757;3991.640752332275;4018.236535058344;3072.6312842458824;3433.2446861690637;3515.455104458813;3527.8588856445713;3550.04148879801;4885.340479035321;5063.772130254148;5079.415867175285;5085.974570127163;5116.258142569344;4495.011097558565;4569.794359253841;4590.242609969351;4601.953980460186;4612.561806628365;5043.722595257259;5412.837614871521;5427.402985671573;5461.351244646344;5462.6449280797015;3170.936581268362;3570.321638888603;3870.148567315186;3883.81543629193;3893.3186692328727;4583.839565615188;4711.623070154379;5073.3911930568565;5773.88452230953;5803.506701930341;3688.5942546319884;3829.6553310202216;3842.558105817811;3844.3656796628243;3853.556840963325;3880.9223815523533;3889.5138107736534;3893.552241492265;3908.218356328746;3918.1575961168487;4336.306191009423;4442.511323754385;4516.412866327357;4527.026689261825;4543.7728113594185;5500.944990550123;5501.322096760527;5503.642263252876;5504.697241651667;5561.277033985556;1051.663467690347;1064.21248276275;1076.5747529725716;1201.9459124339426;1272.5418849214275;850.910654381281;865.4807115730637;870.1298701298701;872.1757938747822;872.9742552500786;4253.447051883235;4315.438992930899;4361.563843615613;4392.670549708785;4730.219513780256;5034.647574669738;5283.6037297202865;5294.54996325309;5367.698865197954;5385.676859388449;4470.6870519064005;4475.440569928759;4480.439945006874;4816.518348165156;4817.325574419584;2758.1311886755607;2761.5443451830624;2764.447110577852;2766.7094955029434;2774.5838124281518;4631.467381251132;4673.719576825401;5415.6479828811;5453.500287420991;5493.533049690741;4158;5096.929644774565;5229.848599129854;5400.594955378362;5424.349078110652;4244.702870799015;4993.950060499348;5042.319286896295;5423.864403389947;5462.890742185214;4713.340132381538;4839.588634966068;4962.950370496394;5026.2127029291905;5233.659812112201;4837.467878533288;4958.801647934042;5019.837502373482;5111.948880511147;5189.481051894781;4529.547045295444;4647.907041859212;4947.505249475023;5203.479652034766;5235.952809438051;2984.597079394254;3555.1467647763834;3584.229390681016;3598.7660802047785;3600.297941901304;5171.431712118626;5651.2935883014625;5678.5457163426;5714.257146570919;5761.452661997104;4597.563231493003;5482.780688772405;5513.696746678971;5524.585656075891;5528.336599608073;5195.376554813447;5458.4814442627885;5533.474319939599;5544.417836127149;5559.916601251065;4740.739259340769;5132.5124113209185;5195.272661827272;5385.973070134624;5434.413287230409;4707.587723682813;5189.4032186297545;5385;5399.352077750695;5564.221009058816;4433.866983990485;4756.429228492603;5421.801137328837;5447.809326673548;5461.317335333083 10:19:09 INFO - PROCESS | 1905 | |5;yui.html;658.887989041863;720.5172534401947;782.7964729170413;823.715818042775;831.2477208126647;14935.775963360546;15608;15821.20893955302;15836.920815395935;15839.683206335882;14298.714025719506;14474.710505789877;14477.348519316629;14478.927605361985;14532.709345813077;707.3421717802441;722.0000299585087;855.3713020929612;859.1451505751754;874.6064271078009;840.4033136473112;851.6848765956605;853.6158728572136;854.2866706300216;858.1161403754144;903.0247332880506;903.1961554216753;904.5432056811334;908.7955210077713;910.1399177777004;901.6618767962015;903.6159632156373;903.8011637439819;904.9547522623842;905.6377449020379;562.2718579439636;673.2526895146384;675.5710124071201;675.7398401615364;679.751890559947;14263.429462821474;14295.142291462545;14335.78496322556;14356.06685565435;15267.923660381739;12866.67833304175;13066.085374023822;13381.732365352638;13391.464341426332;13476.93261533686;11491.94254028733;11616.883831161666;11655.533778648844;11752.764944701059;12000.69998250042;3701.833417496219;3828.2343531293855;3839.4432807243074;3905.9804700976597;3956.8219430125714;94557;96246.51876740642;98529.5073524635;100055.49972250166;100095;10500.527476263434;10856.565737370416;11069.723256918642;11148.777024459465;11173.944130279297;20915;21045.78954210469;21071.473213169793;21164.25925092645;21618.45953851135;7662.5402475850515;7823.960880195563;7838.960805195938;7960.283574478325;8047.798805029921;4246.766427846498;4466.642668586505;4492.483364413134;4544.363789069533;4693.741844198602;2777.5139350613563;3628;3668.192997540537;3673.3020726061964;3770.490983717163;634.194572892424;732.1653315220652;743.3644234179699;749.4940914882433;755.9886601700979;589.602018637418;612.552836429409;614.023702313324;669.1835960128635;687.2028447001454;8495.532745699045;9456.8581471278;9513.524323783922;9577.425354478613;9665;649.2371463530333;652.1326635574675;687.0998991321385;691.8547105107983;706.2901783707341;3595.8561657533405;3757.4176002719623;3939.625735555118;4968.141469766656;5072.137736584789;53802.73098634482;70002.59994800178;75978.24021759712;109840;112518;96902.51548742212;98707.51938720925;99786;103052.48473757734;104125.47937260417;69816.30183698199;70589;72327.6383618089;88306;91708;9568.569414376509;9992.800143996934;10075.949620251851;10088.192944564564;10099.394036357842;45428.77285613551;49670;52170.47829521656;52586.474135258155;53465.732671336395;66903.66548167227;69531;70156.29843701702;72368.63815681098;72538.91191632024;12665.303408312631;12955.093143480242;13044.282564459047;13046.34768261602;13307.933460332637;14120.576382708536;14516;14777.704445911237;14998.550043498712;15531.301091451138;13276.601701948957;13771.311434428439;13844.861551384358;14025.158490490603;14223.573292801233;12683.23900565969;13415;13522.79715804244;13891.763680569446;14122.01145919817;13309.733805323645;13396.866031339561;13589.796153057514;13695.863041369857;13781.724365512433;11062.446877656246;11427.714307142389;11475.426228688366;11823.940880295544;12057.397130143283;11283.605073822377;11397.943010285228;11466.426678666201;11529.711757205801;11688.240264382788 10:19:09 INFO - PROCESS | 1905 | __end_tp_report 10:19:09 INFO - PROCESS | 1905 | __start_cc_report 10:19:09 INFO - PROCESS | 1905 | _x_x_mozilla_cycle_collect,1747 10:19:09 INFO - PROCESS | 1905 | __end_cc_report 10:19:09 INFO - PROCESS | 1905 | __startTimestamp1485886749426__endTimestamp 10:19:09 INFO - PROCESS | 1905 | 10:19:09 INFO - PROCESS | 1905 | ------- Summary: start ------- 10:19:09 INFO - PROCESS | 1905 | Number of tests: 6 10:19:09 INFO - PROCESS | 1905 | 10:19:09 INFO - PROCESS | 1905 | [#0] dojo.html Cycles:165 Average:5761.49 Median:6023.07 stddev:633.87 (10.5%) stddev-sans-first:608.15 10:19:09 INFO - PROCESS | 1905 | Values: 3400.8 3403.8 3418.2 3428.5 3483.3 5771.1 5784.2 5789.5 5815.8 5828.1 5732.9 5799.7 5817.8 5829.8 5841.1 5202.0 5210.7 5249.2 5273.8 5334.1 5124.1 5136.1 5142.9 5345.6 5364.5 5187.9 5264.5 5297.9 5299.3 5309.1 5285.2 5331.9 5337.4 5347.9 5390.0 5052.5 5161.2 5236.2 5269.3 5281.5 5689.4 5734.9 5741.3 5751.3 5754.8 6214.6 6256.8 6257.0 6275.4 6281.7 6297.0 6300.5 6310.0 6310.4 6316.6 5686.9 5737.7 5742.5 5789.6 5818.9 6229.4 6241.4 6268.8 6276.3 6292.4 5993.7 6151.1 6165.4 6182.6 6196.5 6125.9 6164.4 6250.1 6254.4 6284.3 6224.5 6229.6 6239.9 6241.1 6247.8 6192.2 6259.1 6272.0 6272.6 6273.7 4854.6 4926.9 4928.5 4932.8 4959.7 4496.7 4506.3 4518.8 4533.5 4574.8 4933.2 5705.2 5729.7 5818.3 5842.7 6120.4 6139.0 6224.4 6267.2 6278.6 5020.3 5417.8 5809.2 5840.9 5874.1 5396.7 5420.0 5434.8 5441.2 5445.8 6192.7 6247.5 6329.8 6332.4 6358.7 6151.8 6207.5 6215.4 6227.9 6244.0 6267.5 6369.3 6377.1 6381.3 6396.9 6148.0 6164.2 6209.0 6225.1 6226.0 6108.5 6138.6 6190.3 6272.3 6299.6 6023.1 6108.9 6175.7 6180.7 6187.9 6099.3 6159.9 6161.8 6163.9 6169.7 4752.2 5875.6 6021.9 6056.5 6083.2 6096.3 6110.9 6120.0 6160.8 6165.5 5839.7 5893.2 5903.4 6030.3 6056.7 10:19:09 INFO - PROCESS | 1905 | 10:19:09 INFO - PROCESS | 1905 | [#1] ext.html Cycles:180 Average:59316.20 Median:35687.32 stddev:123502.01 (346.1%) stddev-sans-first:123769.42 10:19:09 INFO - PROCESS | 1905 | Values: 463.7 478.7 505.2 524.3 526.2 32409.0 40179.2 40635.6 40676.2 40715.0 43578.8 44452.6 44995.8 45035.3 45062.5 8938.9 9624.1 9809.0 9812.4 9814.0 8931.8 11904.5 12191.5 12201.4 12203.0 11963.0 12056.5 12063.4 12066.6 12068.0 12007.7 12064.0 12066.4 12080.5 12084.9 11731.7 11804.2 11812.4 11832.1 11835.5 41481.0 41692.4 41757.4 41813.2 41829.6 3325.0 3522.8 3719.5 3815.6 4060.9 28258.0 29059.0 29095.9 29673.0 31136.7 3264.7 3352.4 3413.0 3435.8 3455.0 503539.0 504993.0 505204.0 506642.5 506911.0 47457.8 58881.7 61930.7 62261.0 62557.0 65722.7 65755.0 65812.3 65875.7 66056.0 16616.3 17025.4 17030.6 17046.0 17053.5 11563.8 11814.5 12919.9 13164.4 13167.5 12412.3 14237.6 14860.0 14861.4 15000.0 5755.3 5790.4 6170.0 6412.8 6526.1 827.8 873.6 1010.0 1046.4 1073.2 30476.4 30625.9 30779.0 31074.5 31119.4 1011.3 1071.1 1099.9 1122.7 1141.6 15584.4 15846.0 15893.3 16107.2 16314.8 191086.0 191190.0 191757.0 192195.0 192271.0 51105.2 51898.0 58872.7 60018.8 60021.4 1390.9 1425.1 1435.7 1439.8 1442.1 28381.0 28422.3 31043.0 31241.9 32031.4 52045.7 52652.5 52675.7 52723.2 52737.2 582794.0 589938.0 589964.0 590048.0 590963.0 40325.2 40941.2 41179.0 41206.4 41667.0 47885.0 48858.8 48914.8 49251.8 49479.5 35725.0 39488.8 39620.6 40356.8 40394.0 32897.7 39415.0 40007.8 40148.4 40458.4 38792.4 38958.8 39549.6 39650.6 39967.8 28315.4 34387.0 35368.8 35409.3 35649.6 22253.0 26214.3 26420.0 26522.2 26535.2 10:19:09 INFO - PROCESS | 1905 | 10:19:09 INFO - PROCESS | 1905 | [#2] jquery.html Cycles:180 Average:36030.28 Median:23023.15 stddev:103552.51 (449.8%) stddev-sans-first:103808.43 10:19:09 INFO - PROCESS | 1905 | Values: 393.3 396.3 401.1 401.3 415.2 20237.6 20414.7 21011.0 21374.3 21432.4 20307.9 20404.5 20983.7 21305.4 21552.9 5538.8 5907.0 6224.1 6287.5 6305.8 5974.8 6104.1 6173.3 6226.6 6238.0 6215.5 6218.6 6218.7 6218.9 6222.1 6052.2 6062.0 6127.5 6131.4 6202.5 5383.3 5383.7 5384.4 5386.2 5391.8 26743.7 26809.2 26991.7 27000.1 27261.3 2311.2 2451.8 2539.8 2796.3 2800.4 15842.3 16065.8 16092.9 16383.0 16789.3 1858.1 1892.1 1902.4 1927.3 1957.5 102982.0 118136.4 123038.0 125428.0 131066.0 10976.6 10996.6 11507.4 11525.1 11769.7 14468.2 14506.3 14512.3 14536.9 14550.4 8035.8 8737.7 8756.5 8874.6 8876.0 8715.5 8740.2 8763.0 8874.5 8898.6 5646.9 6755.0 6897.0 6897.3 6918.8 1435.2 1916.3 1939.8 1943.8 1970.9 788.2 799.6 875.6 991.7 1077.2 21938.9 22742.8 22907.3 23007.0 23039.3 985.0 1007.9 1030.6 1037.3 1067.5 11822.3 12025.5 12261.0 12273.6 12278.4 612327.0 618475.0 620284.0 630049.0 630191.0 121568.8 123338.0 127766.0 127947.0 133858.3 1039.3 1045.6 1049.8 1068.1 1070.8 18851.3 19420.0 19956.4 20042.4 20052.5 34432.0 43990.1 44395.9 51589.0 53010.0 70755.6 71686.0 80447.8 81226.0 86188.7 7675.8 8218.4 8347.2 8469.0 8501.4 9447.5 12886.4 13642.4 13715.0 13776.2 11315.4 11361.1 11649.9 11835.8 11979.7 11211.9 11317.9 11327.1 11667.4 11796.4 11088.9 11374.6 11529.1 11817.5 11993.3 8330.3 8394.2 8594.1 8640.4 8829.6 9743.4 9994.0 11529.6 11799.9 11951.1 10:19:09 INFO - PROCESS | 1905 | 10:19:09 INFO - PROCESS | 1905 | [#3] mootools.html Cycles:180 Average:5497.05 Median:5084.87 stddev:3004.11 (59.1%) stddev-sans-first:2996.54 10:19:09 INFO - PROCESS | 1905 | Values: 1371.5 1513.6 1675.8 1838.5 1856.3 6623.6 8565.1 8565.7 8570.8 8574.0 7559.3 7772.1 7780.5 7857.7 8389.5 2152.2 2186.9 2308.9 2382.6 2383.2 2416.0 2426.6 2426.8 2427.2 2428.2 1964.7 2400.3 2400.4 2401.4 2402.5 2364.2 2374.1 2393.9 2402.0 2403.2 2392.6 2394.8 2414.7 2421.3 2425.2 8376.9 8554.7 8558.0 8563.2 8569.0 5164.7 5319.7 5321.1 5322.3 5324.9 3326.8 3546.1 3589.4 3594.1 3624.6 1037.2 1069.9 1110.2 1124.4 1127.5 11083.6 11122.6 11129.4 11135.3 11145.5 4440.8 4540.3 4669.9 4672.3 4755.5 8804.0 8867.0 8869.2 8870.0 8892.3 5077.1 5082.8 5086.9 5089.2 5090.0 4631.5 4775.8 4779.9 4810.0 4877.1 3323.9 3475.7 3605.9 3627.6 3849.3 994.8 1158.9 1177.7 1177.8 1190.2 816.5 889.0 894.9 897.9 933.0 5307.4 5655.2 5841.3 5884.9 6015.7 821.8 962.4 964.9 965.3 1011.1 3913.0 3946.7 3947.8 3987.5 4099.1 9886.9 10340.9 10342.7 10347.9 10360.7 9848.7 10271.3 10294.9 10301.7 10301.9 7791.3 8113.1 8120.8 8125.8 8148.2 4448.5 5778.9 5833.8 5957.0 6143.6 9306.4 9585.5 9606.5 9692.7 9731.5 8315.9 9339.8 9593.9 9808.3 9853.3 6248.5 7251.6 7325.2 7451.1 7480.9 7316.5 7589.5 7867.1 8118.8 8129.9 7315.4 7339.1 7342.3 7342.4 7499.6 7187.1 7196.0 7201.8 7211.3 7241.5 6752.4 6831.3 6890.1 6897.7 6900.2 4764.7 4868.7 4871.3 4908.5 4914.0 4263.2 4872.0 4908.4 5035.6 5076.0 10:19:09 INFO - PROCESS | 1905 | 10:19:09 INFO - PROCESS | 1905 | [#4] prototype.html Cycles:180 Average:4311.37 Median:4735.48 stddev:1311.33 (27.7%) stddev-sans-first:1279.26 10:19:09 INFO - PROCESS | 1905 | Values: 259.5 272.4 314.2 321.6 327.9 4954.4 5060.5 5248.8 5269.8 5293.2 4074.2 5124.3 5181.5 5205.9 5238.7 3046.6 3202.7 3517.6 4042.4 4057.4 3661.0 3768.4 4004.6 4025.9 4060.8 3571.0 3612.4 3689.5 4000.6 4041.9 3982.3 3985.2 3989.2 3991.6 4018.2 3072.6 3433.2 3515.5 3527.9 3550.0 4885.3 5063.8 5079.4 5086.0 5116.3 4495.0 4569.8 4590.2 4602.0 4612.6 5043.7 5412.8 5427.4 5461.4 5462.6 3170.9 3570.3 3870.1 3883.8 3893.3 4583.8 4711.6 5073.4 5773.9 5803.5 3688.6 3829.7 3842.6 3844.4 3853.6 3880.9 3889.5 3893.6 3908.2 3918.2 4336.3 4442.5 4516.4 4527.0 4543.8 5500.9 5501.3 5503.6 5504.7 5561.3 1051.7 1064.2 1076.6 1201.9 1272.5 850.9 865.5 870.1 872.2 873.0 4253.4 4315.4 4361.6 4392.7 4730.2 5034.6 5283.6 5294.5 5367.7 5385.7 4470.7 4475.4 4480.4 4816.5 4817.3 2758.1 2761.5 2764.4 2766.7 2774.6 4631.5 4673.7 5415.6 5453.5 5493.5 4158.0 5096.9 5229.8 5400.6 5424.3 4244.7 4994.0 5042.3 5423.9 5462.9 4713.3 4839.6 4963.0 5026.2 5233.7 4837.5 4958.8 5019.8 5111.9 5189.5 4529.5 4647.9 4947.5 5203.5 5236.0 2984.6 3555.1 3584.2 3598.8 3600.3 5171.4 5651.3 5678.5 5714.3 5761.5 4597.6 5482.8 5513.7 5524.6 5528.3 5195.4 5458.5 5533.5 5544.4 5559.9 4740.7 5132.5 5195.3 5386.0 5434.4 4707.6 5189.4 5385.0 5399.4 5564.2 4433.9 4756.4 5421.8 5447.8 5461.3 10:19:09 INFO - PROCESS | 1905 | 10:19:09 INFO - PROCESS | 1905 | [#5] yui.html Cycles:180 Average:20164.21 Median:3948.22 stddev:28743.00 (728.0%) stddev-sans-first:28786.31 10:19:09 INFO - PROCESS | 1905 | Values: 658.9 720.5 782.8 823.7 831.2 14935.8 15608.0 15821.2 15836.9 15839.7 14298.7 14474.7 14477.3 14478.9 14532.7 707.3 722.0 855.4 859.1 874.6 840.4 851.7 853.6 854.3 858.1 903.0 903.2 904.5 908.8 910.1 901.7 903.6 903.8 905.0 905.6 562.3 673.3 675.6 675.7 679.8 14263.4 14295.1 14335.8 14356.1 15267.9 12866.7 13066.1 13381.7 13391.5 13476.9 11491.9 11616.9 11655.5 11752.8 12000.7 3701.8 3828.2 3839.4 3906.0 3956.8 94557.0 96246.5 98529.5 100055.5 100095.0 10500.5 10856.6 11069.7 11148.8 11173.9 20915.0 21045.8 21071.5 21164.3 21618.5 7662.5 7824.0 7839.0 7960.3 8047.8 4246.8 4466.6 4492.5 4544.4 4693.7 2777.5 3628.0 3668.2 3673.3 3770.5 634.2 732.2 743.4 749.5 756.0 589.6 612.6 614.0 669.2 687.2 8495.5 9456.9 9513.5 9577.4 9665.0 649.2 652.1 687.1 691.9 706.3 3595.9 3757.4 3939.6 4968.1 5072.1 53802.7 70002.6 75978.2 109840.0 112518.0 96902.5 98707.5 99786.0 103052.5 104125.5 69816.3 70589.0 72327.6 88306.0 91708.0 9568.6 9992.8 10075.9 10088.2 10099.4 45428.8 49670.0 52170.5 52586.5 53465.7 66903.7 69531.0 70156.3 72368.6 72538.9 12665.3 12955.1 13044.3 13046.3 13307.9 14120.6 14516.0 14777.7 14998.6 15531.3 13276.6 13771.3 13844.9 14025.2 14223.6 12683.2 13415.0 13522.8 13891.8 14122.0 13309.7 13396.9 13589.8 13695.9 13781.7 11062.4 11427.7 11475.4 11823.9 12057.4 11283.6 11397.9 11466.4 11529.7 11688.2 10:19:09 INFO - PROCESS | 1905 | -------- Summary: end -------- 10:19:09 INFO - PROCESS | 1905 | 10:19:09 INFO - TEST-INFO | 1905: exit 0 10:19:10 INFO - TEST-OK | dromaeo_css | took 1116916ms 10:19:10 INFO - TEST-START | kraken 10:19:10 INFO - operating with platform_type : mac_ 10:19:10 INFO - Initialising browser for kraken test... 10:19:10 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpphD3ro/profile http://localhost:51535/getInfo.html) 10:19:12 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 10:19:12 INFO - PROCESS | 1909 | colorDepth:24 10:19:12 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 10:19:12 INFO - PROCESS | 1909 | __metrics 10:19:12 INFO - PROCESS | 1909 | 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" 10:19:12 INFO - PROCESS | 1909 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:13 INFO - TEST-INFO | 1909: exit 0 10:19:13 INFO - Browser initialized. 10:19:13 INFO - Running cycle 1/1 for kraken test... 10:19:13 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpphD3ro/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:25 INFO - PROCESS | 1911 | RSS: Main: 171802624 10:19:25 INFO - PROCESS | 1911 | 10:19:28 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51535/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:29 INFO - PROCESS | 1911 | RSS: Main: 223264768 10:19:29 INFO - PROCESS | 1911 | 10:19:31 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51535/tests/kraken/driver.html?testName=audio-dft) 10:19:32 INFO - PROCESS | 1911 | RSS: Main: 235335680 10:19:32 INFO - PROCESS | 1911 | 10:19:35 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51535/tests/kraken/driver.html?testName=audio-fft) 10:19:36 INFO - PROCESS | 1911 | RSS: Main: 330244096 10:19:36 INFO - PROCESS | 1911 | 10:19:38 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51535/tests/kraken/driver.html?testName=audio-oscillator) 10:19:38 INFO - PROCESS | 1911 | RSS: Main: 231624704 10:19:38 INFO - PROCESS | 1911 | 10:19:40 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51535/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:41 INFO - PROCESS | 1911 | RSS: Main: 232882176 10:19:41 INFO - PROCESS | 1911 | 10:19:44 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51535/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:44 INFO - PROCESS | 1911 | RSS: Main: 273920000 10:19:44 INFO - PROCESS | 1911 | 10:19:47 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51535/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:48 INFO - PROCESS | 1911 | RSS: Main: 275337216 10:19:48 INFO - PROCESS | 1911 | 10:19:50 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51535/tests/kraken/driver.html?testName=json-parse-financial) 10:19:51 INFO - PROCESS | 1911 | RSS: Main: 273461248 10:19:51 INFO - PROCESS | 1911 | 10:19:53 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51535/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:19:53 INFO - PROCESS | 1911 | RSS: Main: 248877056 10:19:53 INFO - PROCESS | 1911 | 10:19:55 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:19:56 INFO - PROCESS | 1911 | RSS: Main: 249815040 10:19:56 INFO - PROCESS | 1911 | 10:19:58 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:59 INFO - PROCESS | 1911 | RSS: Main: 252383232 10:19:59 INFO - PROCESS | 1911 | 10:20:01 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:02 INFO - PROCESS | 1911 | RSS: Main: 270262272 10:20:02 INFO - PROCESS | 1911 | 10:20:05 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:05 INFO - PROCESS | 1911 | RSS: Main: 264261632 10:20:05 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:51535/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51535/tests/kraken/driver.html?testName=ai-astar) 10:20:07 INFO - PROCESS | 1911 | RSS: Main: 308289536 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | __start_tp_report 10:20:07 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 10:20:07 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 10:20:07 INFO - PROCESS | 1911 | |i|pagename|runs| 10:20:07 INFO - PROCESS | 1911 | |0;ai-astar;113;112;113;111;112;117;160;170;113;112 10:20:07 INFO - PROCESS | 1911 | |1;audio-beat-detection;142;108;109;143;108;109;109;107;136;106 10:20:07 INFO - PROCESS | 1911 | |2;audio-dft;184;184;183;183;183;181;183;184;181;181 10:20:07 INFO - PROCESS | 1911 | |3;audio-fft;83;57;58;90;60;67;59;59;81;54 10:20:07 INFO - PROCESS | 1911 | |4;audio-oscillator;84;68;93;101;66;68;87;68;68;91 10:20:07 INFO - PROCESS | 1911 | |5;imaging-gaussian-blur;118;130;98;84;87;83;86;84;87;83 10:20:07 INFO - PROCESS | 1911 | |6;imaging-darkroom;92;92;93;93;92;91;92;93;92;92 10:20:07 INFO - PROCESS | 1911 | |7;imaging-desaturate;82;84;79;81;84;80;85;86;84;81 10:20:07 INFO - PROCESS | 1911 | |8;json-parse-financial;44;50;53;79;56;57;58;54;54;79 10:20:07 INFO - PROCESS | 1911 | |9;json-stringify-tinderbox;63;71;73;77;71;66;68;69;68;70 10:20:07 INFO - PROCESS | 1911 | |10;stanford-crypto-aes;80;85;85;91;100;101;102;81;83;82 10:20:07 INFO - PROCESS | 1911 | |11;stanford-crypto-ccm;138;141;142;138;152;140;139;139;185;137 10:20:07 INFO - PROCESS | 1911 | |12;stanford-crypto-pbkdf2;149;160;160;163;162;159;161;161;161;160 10:20:07 INFO - PROCESS | 1911 | |13;stanford-crypto-sha256-iterative;65;66;66;66;65;65;66;65;65;66 10:20:07 INFO - PROCESS | 1911 | __end_tp_report 10:20:07 INFO - PROCESS | 1911 | __start_cc_report 10:20:07 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,1850 10:20:07 INFO - PROCESS | 1911 | __end_cc_report 10:20:07 INFO - PROCESS | 1911 | __startTimestamp1485886807848__endTimestamp 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | ------- Summary: start ------- 10:20:07 INFO - PROCESS | 1911 | Number of tests: 14 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#0] ai-astar Cycles:10 Average:123.30 Median:113.00 stddev:22.16 (19.6%) stddev-sans-first:23.19 10:20:07 INFO - PROCESS | 1911 | Values: 113.0 112.0 113.0 111.0 112.0 117.0 160.0 170.0 113.0 112.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:109.00 stddev:15.75 (14.4%) stddev-sans-first:14.04 10:20:07 INFO - PROCESS | 1911 | Values: 142.0 108.0 109.0 143.0 108.0 109.0 109.0 107.0 136.0 106.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.25 (0.7%) stddev-sans-first:1.24 10:20:07 INFO - PROCESS | 1911 | Values: 184.0 184.0 183.0 183.0 183.0 181.0 183.0 184.0 181.0 181.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#3] audio-fft Cycles:10 Average:66.80 Median:63.50 stddev:12.94 (20.4%) stddev-sans-first:12.33 10:20:07 INFO - PROCESS | 1911 | Values: 83.0 57.0 58.0 90.0 60.0 67.0 59.0 59.0 81.0 54.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:76.00 stddev:13.18 (17.3%) stddev-sans-first:13.88 10:20:07 INFO - PROCESS | 1911 | Values: 84.0 68.0 93.0 101.0 66.0 68.0 87.0 68.0 68.0 91.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:85.00 stddev:16.64 (19.6%) stddev-sans-first:15.22 10:20:07 INFO - PROCESS | 1911 | Values: 118.0 130.0 98.0 84.0 87.0 83.0 86.0 84.0 87.0 83.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#6] imaging-darkroom Cycles:10 Average:92.20 Median:92.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 10:20:07 INFO - PROCESS | 1911 | Values: 92.0 92.0 93.0 93.0 92.0 91.0 92.0 93.0 92.0 92.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#7] imaging-desaturate Cycles:10 Average:82.60 Median:84.00 stddev:2.32 (2.8%) stddev-sans-first:2.45 10:20:07 INFO - PROCESS | 1911 | Values: 82.0 84.0 79.0 81.0 84.0 80.0 85.0 86.0 84.0 81.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:56.50 stddev:11.56 (20.5%) stddev-sans-first:11.02 10:20:07 INFO - PROCESS | 1911 | Values: 44.0 50.0 53.0 79.0 56.0 57.0 58.0 54.0 54.0 79.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.50 stddev:3.84 (5.4%) stddev-sans-first:3.24 10:20:07 INFO - PROCESS | 1911 | Values: 63.0 71.0 73.0 77.0 71.0 66.0 68.0 69.0 68.0 70.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:82.50 stddev:8.82 (10.7%) stddev-sans-first:8.73 10:20:07 INFO - PROCESS | 1911 | Values: 80.0 85.0 85.0 91.0 100.0 101.0 102.0 81.0 83.0 82.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:140.50 stddev:14.65 (10.4%) stddev-sans-first:15.32 10:20:07 INFO - PROCESS | 1911 | Values: 138.0 141.0 142.0 138.0 152.0 140.0 139.0 139.0 185.0 137.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:161.00 stddev:3.89 (2.4%) stddev-sans-first:1.20 10:20:07 INFO - PROCESS | 1911 | Values: 149.0 160.0 160.0 163.0 162.0 159.0 161.0 161.0 161.0 160.0 10:20:07 INFO - PROCESS | 1911 | 10:20:07 INFO - PROCESS | 1911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 10:20:07 INFO - PROCESS | 1911 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 66.0 65.0 65.0 66.0 10:20:07 INFO - PROCESS | 1911 | -------- Summary: end -------- 10:20:07 INFO - PROCESS | 1911 | 10:20:08 INFO - TEST-INFO | 1911: exit 0 10:20:08 INFO - TEST-OK | kraken | took 58821ms 10:20:08 INFO - SUITE-END | took 1175s 10:20:09 INFO - Completed test suite (00:19:35) 10:20:09 INFO - javascript benchmark 10:20:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3400.778949368291, 3403.829808509577, 3418.230898047939, 3428.48572714093, 3483.320752453271, 5771.134329850524, 5784.161296611988, 5789.507891829189, 5815.767369305228, 5828.067509198524, 5732.856678583037, 5799.710014499279, 5817.796377126801, 5829.766809327622, 5841.123831425289, 5202.0, 5210.713410762407, 5249.1601343785005, 5273.789048438077, 5334.146536554152, 5124.128898087315, 5136.126858434057, 5142.948570514284, 5345.599080068991, 5364.463553644624, 5187.896242075156, 5264.526192642661, 5297.867553311159, 5299.33758280215, 5309.0709125903, 5285.154375299952, 5331.893362132736, 5337.386200586943, 5347.919781203285, 5390.0, 5052.494750524955, 5161.225816127573, 5236.21456781482, 5269.262303277545, 5281.498257665554, 5689.402612725687, 5734.942650573483, 5741.33974592923, 5751.281089863767, 5754.769809207627, 6214.627122372627, 6256.812295631093, 6257.030160325156, 6275.435210831047, 6281.748730050793, 6296.96851515744, 6300.495960323163, 6310.0, 6310.368963103699, 6316.621002739805, 5686.943130568683, 5737.655740655616, 5742.511886489611, 5789.623674461147, 5818.883622327529, 6229.4393504583895, 6241.407066328691, 6268.780592679325, 6276.278228003746, 6292.433680968643, 5993.730282137314, 6151.053846652444, 6165.352637972948, 6182.598131121463, 6196.47329976948, 6125.876495711566, 6164.352742961924, 6250.062490626351, 6254.437100660963, 6284.340144284875, 6224.502039836802, 6229.595076320115, 6239.875202495925, 6241.095041218998, 6247.843803904848, 6192.225971753531, 6259.061140828912, 6271.9686401568615, 6272.5922815016875, 6273.749050037947, 4854.563089321978, 4926.926096108561, 4928.457869634337, 4932.753362331869, 4959.652824302337, 4496.730196188174, 4506.278995360726, 4518.774061296987, 4533.52397998212, 4574.83988060423, 4933.161362568372, 5705.2012718219485, 5729.713514324267, 5818.301803783573, 5842.737076831553, 6120.416658367975, 6139.0, 6224.439800417984, 6267.185265915493, 6278.560500764903, 5020.272060551272, 5417.83746487606, 5809.157672137517, 5840.941590584125, 5874.060150375919, 5396.676199428047, 5419.972900135553, 5434.755436005389, 5441.183822426668, 5445.782168713286, 6192.690365481798, 6247.468965138014, 6329.778457753957, 6332.430081292706, 6358.7456501740335, 6151.815445536641, 6207.472364849038, 6215.378462153929, 6227.9377206227355, 6244.0, 6267.467265282502, 6369.33122022181, 6377.1390862233, 6381.329960354096, 6396.9040464394, 6148.047052706837, 6164.167837342081, 6209.037599172136, 6225.066240063846, 6225.968870155621, 6108.4807791338235, 6138.602983405075, 6190.2571691397325, 6272.310045895039, 6299.590526615755, 6023.066424704178, 6108.8778224436155, 6175.6912154393, 6180.721867516063, 6187.876242475035, 6099.268087829311, 6159.938400615936, 6161.815145545641, 6163.907541386793, 6169.691515424301, 4752.239641657318, 5875.559333049953, 6021.946159421996, 6056.454919057306, 6083.209182806207, 6096.268447786294, 6110.8929201734545, 6119.999800813725, 6160.815175544741, 6165.506759459322, 5839.678817664899, 5893.233879595625, 5903.380145084704, 6030.30651475086, 6056.727447264796], "value": 5722.170697694693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.7472577445292, 478.68646036845854, 505.15891041416046, 524.3236225269401, 526.1686535274267, 32409.0, 40179.19641607166, 40635.59364406355, 40676.18647627046, 40715.0, 43578.78210608943, 44452.555474445326, 44995.77502112485, 45035.324470132975, 45062.54937450625, 8938.910610893905, 9624.085711857362, 9809.0, 9812.411255324703, 9814.018598140201, 8931.821363572724, 11904.464299106561, 12191.451384687665, 12201.389930503483, 12203.0, 11963.0, 12056.457459414347, 12063.396830158501, 12066.638000859988, 12067.974222191124, 12007.699807504838, 12064.0, 12066.396680165957, 12080.456379462901, 12084.879151208463, 11731.7067073323, 11804.232724872942, 11812.40937953099, 11832.053435725207, 11835.526578936831, 41481.0, 41692.37461438081, 41757.37363939543, 41813.163736725095, 41829.58170418287, 3325.0042309185505, 3522.7710198836994, 3719.4606782016726, 3815.5993620669983, 4060.9187816243807, 28258.0, 29059.0, 29095.854520727262, 29673.0, 31136.68863311383, 3264.657210992835, 3352.4133276676484, 3413.044347582681, 3435.8282085895853, 3454.9827250863586, 503539.0, 504993.0, 505204.0, 506642.46678766736, 506911.0, 47457.762711186224, 58881.70559147262, 61930.69034654798, 62261.0, 62557.0, 65722.67138664372, 65755.0, 65812.34187658157, 65875.67062164658, 66056.00915986265, 16616.25226864794, 17025.40411085606, 17030.57423564396, 17046.0, 17053.48839534816, 11563.826542601868, 11814.46834892432, 12919.901808346207, 13164.40760165795, 13167.539136130381, 12412.317322547347, 14237.64405889861, 14860.0, 14861.405543778345, 14999.95000349987, 5755.309362876482, 5790.42095790426, 6170.0, 6412.807615771534, 6526.118973938553, 827.7914245202072, 873.6025108575583, 1009.9848502272472, 1046.424466543398, 1073.2272763610188, 30476.390472190433, 30625.9280925171, 30779.0, 31074.53388199179, 31119.377612448076, 1011.2718842433436, 1071.132382769959, 1099.9285046472114, 1122.7249323915694, 1141.6004398460639, 15584.350660387761, 15846.0, 15893.284802183929, 16107.194640268173, 16314.83685163157, 191086.04456977625, 191190.0, 191757.0, 192195.0, 192271.03864480587, 51105.233421498706, 51897.962040758975, 58872.7056364724, 60018.799624007275, 60021.399786002454, 1390.8539603341503, 1425.0879437160227, 1435.7056803355497, 1439.805626240444, 1442.0986883198002, 28381.0, 28422.289442764097, 31043.0, 31241.906533271227, 32031.35937281288, 52045.7397713009, 52652.47347526476, 52675.736621316646, 52723.20915186352, 52737.20894186514, 582794.0, 589938.0, 589964.0, 590048.0, 590963.0451847713, 40325.1934961305, 40941.18117637571, 41179.0, 41206.38190427206, 41667.0, 47885.04229915452, 48858.77853053702, 48914.75542622264, 49251.76870578264, 49479.50520494749, 35725.0, 39488.80255598704, 39620.603793961694, 40356.789296321156, 40394.0, 32897.67102328946, 39415.0, 40007.79996100001, 40148.39777403283, 40458.39312410375, 38792.418113727756, 38958.80520597379, 39549.60450395574, 39650.60349396469, 39967.80016099901, 28315.433691325645, 34386.968390948314, 35368.823155884056, 35409.29181416306, 35649.643503564635, 22253.0, 26214.344641383355, 26420.0, 26522.204333870013, 26535.187358014366], "value": 20015.10694453844, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.307778310174, 396.2629509113049, 401.0835241473233, 401.3458063356728, 415.2048826497258, 20237.59524809503, 20414.69377959332, 21011.0, 21374.251901183463, 21432.35702928911, 20307.898460507713, 20404.489887752814, 20983.73423598838, 21305.36083917485, 21552.89223553884, 5538.75075621596, 5907.0, 6224.0663900415075, 6287.528435367343, 6305.842353941142, 5974.761009559634, 6104.114903339013, 6173.290071641752, 6226.595271307373, 6237.968810155966, 6215.508278013267, 6218.626882387049, 6218.657973811439, 6218.937810621904, 6222.12890195373, 6052.152698622196, 6061.969690151565, 6127.4791642710425, 6131.417515336036, 6202.534809889254, 5383.327084114486, 5383.676979381211, 5384.40771515133, 5386.245925570423, 5391.838244852622, 26743.73256267432, 26809.19572412831, 26991.73008269912, 27000.05499807517, 27261.318467038283, 2311.2257393773107, 2451.8161137914726, 2539.7935980409343, 2796.2869468285458, 2800.3979144484033, 15842.28709708066, 16065.839341606552, 16092.919535402365, 16383.0, 16789.328426863034, 1858.1452531835373, 1892.0728842867034, 1902.4197619725978, 1927.267638297452, 1957.4812674641232, 102982.0, 118136.40931795286, 123038.0, 125428.0, 131066.0, 10976.615818446477, 10996.560137594566, 11507.424628768527, 11525.135614828921, 11769.705757355963, 14468.204248766418, 14506.274686265644, 14512.346944387527, 14536.85463145355, 14550.417983280762, 8035.7991050223045, 8737.650493980169, 8756.474611523328, 8874.624433212863, 8875.955620221986, 8715.477071375737, 8740.169683880022, 8762.956185219033, 8874.467531948103, 8898.644054237759, 5646.915296270559, 6754.966225168941, 6897.0, 6897.310268973062, 6918.757843475454, 1435.167602790379, 1916.338863092231, 1939.767227932657, 1943.805619438045, 1970.9014549272479, 788.2393490281905, 799.6441583495405, 875.6497401039635, 991.6727479931606, 1077.2190162132392, 21938.89030554837, 22742.772572274065, 22907.31278061661, 23007.0, 23039.308820735405, 984.9753756156153, 1007.8639383683255, 1030.6135199300263, 1037.273908264218, 1067.4769363012224, 11822.34977076252, 12025.518979240733, 12261.0, 12273.631791046282, 12278.386080696107, 612327.0, 618475.0, 620284.0, 630049.0, 630191.0, 121568.78431215751, 123338.0, 127766.0, 127947.0, 133858.33070834583, 1039.2984735303792, 1045.628801775374, 1049.7847941172195, 1068.1294744782977, 1070.8286674132257, 18851.340203093376, 19420.028998550297, 19956.401307960783, 20042.39872803818, 20052.498687532927, 34432.0, 43990.12019759651, 44395.89010274769, 51588.968220634626, 53010.0, 70755.64622176856, 71686.0, 80447.7820887158, 81226.0, 86188.70716939126, 7675.808104797425, 8218.383621228551, 8347.248747612744, 8468.957655211685, 8501.447405918596, 9447.527623618655, 12886.420111094836, 13642.386092625657, 13715.039947203999, 13776.24230667323, 11315.377654229096, 11361.147913906325, 11649.883501165219, 11835.822462662894, 11979.700507487383, 11211.887881121085, 11317.943410282896, 11327.093832493216, 11667.416629168678, 11796.351200684045, 11088.944555277172, 11374.601888933848, 11529.135314851588, 11817.527298907948, 11993.280403175837, 8330.250277475056, 8394.160583941557, 8594.097619749837, 8640.395172337876, 8829.602667879832, 9743.366681165702, 9993.950030249802, 11529.558805149356, 11799.93800557954, 11951.103667225167], "value": 10051.810151396678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.5336785492934, 1513.5988962924828, 1675.849173574378, 1838.485224137242, 1856.3038860427332, 6623.635700036496, 8565.057843637194, 8565.700200492984, 8570.842936203626, 8573.957130214356, 7559.319661230488, 7772.067351917778, 7780.533168009923, 7857.6856925722905, 8389.454685445442, 2152.2251989283886, 2186.890655467228, 2308.9422764430856, 2382.5949588569983, 2383.1778036577352, 2415.9637605435933, 2426.6360045993065, 2426.7815896569305, 2427.174760581402, 2428.1622840120217, 1964.7445832041815, 2400.291913885408, 2400.4238982644215, 2401.399650087478, 2402.543516731824, 2364.207990323244, 2374.085976898889, 2393.940151496209, 2402.0, 2403.170906037414, 2392.605220138675, 2394.844335118212, 2414.6619473273754, 2421.3220298316323, 2425.236050644059, 8376.916230837674, 8554.743357699217, 8557.957210213908, 8563.229309362125, 8569.0, 5164.741762911877, 5319.7340132993195, 5321.068812957756, 5322.308099947021, 5324.866878328034, 3326.800391976489, 3546.060294022086, 3589.3898037333456, 3594.101474631342, 3624.6194149614175, 1037.190991027, 1069.8823129455754, 1110.1562812262657, 1124.3534967393782, 1127.4813585750564, 11083.556657733761, 11122.55509779608, 11129.443527823576, 11135.276207046516, 11145.498452569655, 4440.822367105344, 4540.250858608359, 4669.883252918704, 4672.299155126758, 4755.548222918817, 8803.955980220186, 8866.980297265767, 8869.201771840566, 8870.024297327289, 8892.288616910631, 5077.060743762416, 5082.847514574495, 5086.898262034739, 5089.160288552347, 5089.982003599295, 4631.467381251132, 4775.808967641256, 4779.904401912012, 4810.0, 4877.146499362598, 3323.9031119730917, 3475.669811367916, 3605.8737944171826, 3627.6372362763514, 3849.268638958589, 994.8060128275062, 1158.8783177766213, 1177.7350096228452, 1177.7585594953014, 1190.2382475215868, 816.506013861617, 888.968796196409, 894.852349362361, 897.9449147252084, 932.9860052099224, 5307.363116426053, 5655.179998900218, 5841.328247251536, 5884.882302353929, 6015.699215039231, 821.7904434369198, 962.43216502264, 964.9228061755043, 965.2712202287228, 1011.0900189829213, 3912.980435097806, 3946.723729338919, 3947.822347994347, 3987.501562304712, 4099.139180772071, 9886.901130988743, 10340.948295258626, 10342.689719308433, 10347.896521034843, 10360.689179324632, 9848.655297064568, 10271.332363396356, 10294.948525257476, 10301.742456438498, 10301.896981030093, 7791.298783109547, 8113.148119447373, 8120.796980075427, 8125.796855078552, 8148.185181481805, 4448.510663827041, 5778.913316300175, 5833.766649333979, 5956.987312157031, 6143.56995010345, 9306.441613503212, 9585.472798996123, 9606.471644059644, 9692.660756873476, 9731.464769437749, 8315.875261870955, 9339.813203735752, 9593.904060959301, 9808.313418060952, 9853.261005424765, 6248.468880145057, 7251.564906105439, 7325.194228634739, 7451.143118541437, 7480.887786683313, 7316.451266154953, 7589.468737188344, 7867.095284042409, 8118.83762324762, 8129.9187008129165, 7315.414766818535, 7339.082614673166, 7342.265773422615, 7342.3758980487255, 7499.550026998398, 7187.101612298463, 7196.0, 7201.81995450097, 7211.314925082109, 7241.456890733321, 6752.3922846944015, 6831.316868313129, 6890.10428644273, 6897.655117244218, 6900.171979362509, 4764.690295130806, 4868.683535570177, 4871.269309603446, 4908.460069392436, 4913.950860491493, 4263.232618128766, 4871.951280487291, 4908.410990681141, 5035.597152227886, 5076.010178015252], "value": 4461.629624253592, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.5224786393037, 272.4224643755239, 314.1831238779173, 321.5771260792058, 327.9426100432424, 4954.355933728611, 5060.519250671189, 5248.7927776611405, 5269.78543088716, 5293.206019097132, 4074.1666250187386, 5124.282600435942, 5181.481851814817, 5205.869853253671, 5238.711870847102, 3046.588710524073, 3202.67973202679, 3517.6306487818792, 4042.3532234842432, 4057.4319595256616, 3660.9566273612027, 3768.3593789055926, 4004.619561141687, 4025.859094931678, 4060.817263223162, 3571.0358203285095, 3612.3858943979585, 3689.538807649044, 4000.639942405183, 4041.939370909439, 3982.3429134192825, 3985.2066570043307, 3989.1822176453757, 3991.640752332275, 4018.236535058344, 3072.6312842458824, 3433.2446861690637, 3515.455104458813, 3527.8588856445713, 3550.04148879801, 4885.340479035321, 5063.772130254148, 5079.415867175285, 5085.974570127163, 5116.258142569344, 4495.011097558565, 4569.794359253841, 4590.242609969351, 4601.953980460186, 4612.561806628365, 5043.722595257259, 5412.837614871521, 5427.402985671573, 5461.351244646344, 5462.6449280797015, 3170.936581268362, 3570.321638888603, 3870.148567315186, 3883.81543629193, 3893.3186692328727, 4583.839565615188, 4711.623070154379, 5073.3911930568565, 5773.88452230953, 5803.506701930341, 3688.5942546319884, 3829.6553310202216, 3842.558105817811, 3844.3656796628243, 3853.556840963325, 3880.9223815523533, 3889.5138107736534, 3893.552241492265, 3908.218356328746, 3918.1575961168487, 4336.306191009423, 4442.511323754385, 4516.412866327357, 4527.026689261825, 4543.7728113594185, 5500.944990550123, 5501.322096760527, 5503.642263252876, 5504.697241651667, 5561.277033985556, 1051.663467690347, 1064.21248276275, 1076.5747529725716, 1201.9459124339426, 1272.5418849214275, 850.910654381281, 865.4807115730637, 870.1298701298701, 872.1757938747822, 872.9742552500786, 4253.447051883235, 4315.438992930899, 4361.563843615613, 4392.670549708785, 4730.219513780256, 5034.647574669738, 5283.6037297202865, 5294.54996325309, 5367.698865197954, 5385.676859388449, 4470.6870519064005, 4475.440569928759, 4480.439945006874, 4816.518348165156, 4817.325574419584, 2758.1311886755607, 2761.5443451830624, 2764.447110577852, 2766.7094955029434, 2774.5838124281518, 4631.467381251132, 4673.719576825401, 5415.6479828811, 5453.500287420991, 5493.533049690741, 4158.0, 5096.929644774565, 5229.848599129854, 5400.594955378362, 5424.349078110652, 4244.702870799015, 4993.950060499348, 5042.319286896295, 5423.864403389947, 5462.890742185214, 4713.340132381538, 4839.588634966068, 4962.950370496394, 5026.2127029291905, 5233.659812112201, 4837.467878533288, 4958.801647934042, 5019.837502373482, 5111.948880511147, 5189.481051894781, 4529.547045295444, 4647.907041859212, 4947.505249475023, 5203.479652034766, 5235.952809438051, 2984.597079394254, 3555.1467647763834, 3584.229390681016, 3598.7660802047785, 3600.297941901304, 5171.431712118626, 5651.2935883014625, 5678.5457163426, 5714.257146570919, 5761.452661997104, 4597.563231493003, 5482.780688772405, 5513.696746678971, 5524.585656075891, 5528.336599608073, 5195.376554813447, 5458.4814442627885, 5533.474319939599, 5544.417836127149, 5559.916601251065, 4740.739259340769, 5132.5124113209185, 5195.272661827272, 5385.973070134624, 5434.413287230409, 4707.587723682813, 5189.4032186297545, 5385.0, 5399.352077750695, 5564.221009058816, 4433.866983990485, 4756.429228492603, 5421.801137328837, 5447.809326673548, 5461.317335333083], "value": 3891.2270141541535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.887989041863, 720.5172534401947, 782.7964729170413, 823.715818042775, 831.2477208126647, 14935.775963360546, 15608.0, 15821.20893955302, 15836.920815395935, 15839.683206335882, 14298.714025719506, 14474.710505789877, 14477.348519316629, 14478.927605361985, 14532.709345813077, 707.3421717802441, 722.0000299585087, 855.3713020929612, 859.1451505751754, 874.6064271078009, 840.4033136473112, 851.6848765956605, 853.6158728572136, 854.2866706300216, 858.1161403754144, 903.0247332880506, 903.1961554216753, 904.5432056811334, 908.7955210077713, 910.1399177777004, 901.6618767962015, 903.6159632156373, 903.8011637439819, 904.9547522623842, 905.6377449020379, 562.2718579439636, 673.2526895146384, 675.5710124071201, 675.7398401615364, 679.751890559947, 14263.429462821474, 14295.142291462545, 14335.78496322556, 14356.06685565435, 15267.923660381739, 12866.67833304175, 13066.085374023822, 13381.732365352638, 13391.464341426332, 13476.93261533686, 11491.94254028733, 11616.883831161666, 11655.533778648844, 11752.764944701059, 12000.69998250042, 3701.833417496219, 3828.2343531293855, 3839.4432807243074, 3905.9804700976597, 3956.8219430125714, 94557.0, 96246.51876740642, 98529.5073524635, 100055.49972250166, 100095.0, 10500.527476263434, 10856.565737370416, 11069.723256918642, 11148.777024459465, 11173.944130279297, 20915.0, 21045.78954210469, 21071.473213169793, 21164.25925092645, 21618.45953851135, 7662.5402475850515, 7823.960880195563, 7838.960805195938, 7960.283574478325, 8047.798805029921, 4246.766427846498, 4466.642668586505, 4492.483364413134, 4544.363789069533, 4693.741844198602, 2777.5139350613563, 3628.0, 3668.192997540537, 3673.3020726061964, 3770.490983717163, 634.194572892424, 732.1653315220652, 743.3644234179699, 749.4940914882433, 755.9886601700979, 589.602018637418, 612.552836429409, 614.023702313324, 669.1835960128635, 687.2028447001454, 8495.532745699045, 9456.8581471278, 9513.524323783922, 9577.425354478613, 9665.0, 649.2371463530333, 652.1326635574675, 687.0998991321385, 691.8547105107983, 706.2901783707341, 3595.8561657533405, 3757.4176002719623, 3939.625735555118, 4968.141469766656, 5072.137736584789, 53802.73098634482, 70002.59994800178, 75978.24021759712, 109840.0, 112518.0, 96902.51548742212, 98707.51938720925, 99786.0, 103052.48473757734, 104125.47937260417, 69816.30183698199, 70589.0, 72327.6383618089, 88306.0, 91708.0, 9568.569414376509, 9992.800143996934, 10075.949620251851, 10088.192944564564, 10099.394036357842, 45428.77285613551, 49670.0, 52170.47829521656, 52586.474135258155, 53465.732671336395, 66903.66548167227, 69531.0, 70156.29843701702, 72368.63815681098, 72538.91191632024, 12665.303408312631, 12955.093143480242, 13044.282564459047, 13046.34768261602, 13307.933460332637, 14120.576382708536, 14516.0, 14777.704445911237, 14998.550043498712, 15531.301091451138, 13276.601701948957, 13771.311434428439, 13844.861551384358, 14025.158490490603, 14223.573292801233, 12683.23900565969, 13415.0, 13522.79715804244, 13891.763680569446, 14122.01145919817, 13309.733805323645, 13396.866031339561, 13589.796153057514, 13695.863041369857, 13781.724365512433, 11062.446877656246, 11427.714307142389, 11475.426228688366, 11823.940880295544, 12057.397130143283, 11283.605073822377, 11397.943010285228, 11466.426678666201, 11529.711757205801, 11688.240264382788], "value": 7482.9811755405, "unit": "score"}], "name": "dromaeo_css", "value": 7285.812270934599, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 111.0, 112.0, 117.0, 160.0, 170.0, 113.0, 112.0], "value": 123.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 109.0, 143.0, 108.0, 109.0, 109.0, 107.0, 136.0, 106.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 183.0, 183.0, 181.0, 183.0, 184.0, 181.0, 181.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 57.0, 58.0, 90.0, 60.0, 67.0, 59.0, 59.0, 81.0, 54.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 68.0, 93.0, 101.0, 66.0, 68.0, 87.0, 68.0, 68.0, 91.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 130.0, 98.0, 84.0, 87.0, 83.0, 86.0, 84.0, 87.0, 83.0], "value": 94.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 93.0, 92.0, 91.0, 92.0, 93.0, 92.0, 92.0], "value": 92.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 79.0, 81.0, 84.0, 80.0, 85.0, 86.0, 84.0, 81.0], "value": 82.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 50.0, 53.0, 79.0, 56.0, 57.0, 58.0, 54.0, 54.0, 79.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 73.0, 77.0, 71.0, 66.0, 68.0, 69.0, 68.0, 70.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 85.0, 91.0, 100.0, 101.0, 102.0, 81.0, 83.0, 82.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 142.0, 138.0, 152.0, 140.0, 139.0, 139.0, 185.0, 137.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 160.0, 160.0, 163.0, 162.0, 159.0, 161.0, 161.0, 161.0, 160.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1425.8999999999999, "alertThreshold": 2.0}]} 10:20:09 INFO - Return code: 0 10:20:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:20:09 INFO - # TBPL SUCCESS # 10:20:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:20:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:20:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:20:09 INFO - 2017-01-31 10:20:09.165 screenresolution[1915:14463] starting screenresolution argv=screenresolution get 10:20:09 INFO - 2017-01-31 10:20:09.168 screenresolution[1915:14463] Display 0: 1600x1200x32@60 10:20:09 INFO - 2017-01-31 10:20:09.174 screenresolution[1916:14466] starting screenresolution argv=screenresolution list 10:20:09 INFO - Available Modes on Display 0 10:20:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:20:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:20:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:20:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:20:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:20:09 INFO - Intel Iris: 10:20:09 INFO - Chipset Model: Intel Iris 10:20:09 INFO - Type: GPU 10:20:09 INFO - Bus: Built-In 10:20:09 INFO - VRAM (Dynamic, Max): 1536 MB 10:20:09 INFO - Vendor: Intel (0x8086) 10:20:09 INFO - Device ID: 0x0a2e 10:20:09 INFO - Revision ID: 0x0009 10:20:09 INFO - Displays: 10:20:09 INFO - Display: 10:20:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:20:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:20:09 INFO - Display Serial Number: 1600x1200 60 10:20:09 INFO - Main Display: Yes 10:20:09 INFO - Mirror: Off 10:20:09 INFO - Online: Yes 10:20:09 INFO - Rotation: Supported 10:20:09 INFO - Return code: 0 10:20:09 INFO - Running post-action listener: _resource_record_post_action 10:20:09 INFO - [mozharness: 2017-01-31 18:20:09.416706Z] Finished run-tests step (success) 10:20:09 INFO - Running post-run listener: _resource_record_post_run 10:20:09 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 786432; Write bytes: 495425024; Read time: 9; Write time: 1567 10:20:09 INFO - TinderboxPrint: CPU usage
53.4% 10:20:09 INFO - TinderboxPrint: I/O read bytes / time
786,432 / 9 10:20:09 INFO - TinderboxPrint: I/O write bytes / time
495,425,024 / 1,567 10:20:09 INFO - TinderboxPrint: CPU idle
2,233.0 (46.6%) 10:20:09 INFO - TinderboxPrint: CPU system
959.9 (20.0%) 10:20:09 INFO - TinderboxPrint: CPU user
1,596.8 (33.3%) 10:20:09 INFO - TinderboxPrint: Swap in / out
192,626,688 / 0 10:20:09 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 188369408; Write bytes: 186171392; Read time: 16853; Write time: 405 10:20:09 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 741376; Write bytes: 302073344; Read time: 9; Write time: 1130 10:20:09 INFO - Running post-run listener: _upload_blobber_files 10:20:09 INFO - Blob upload gear active. 10:20:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:20:09 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 10:20:09 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'] 10:20:09 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 10:20:10 INFO - (blobuploader) - INFO - Open directory for files ... 10:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:11 INFO - (blobuploader) - INFO - Done attempting. 10:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:12 INFO - (blobuploader) - INFO - Done attempting. 10:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:20:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:14 INFO - (blobuploader) - INFO - Done attempting. 10:20:14 INFO - (blobuploader) - INFO - Iteration through files over. 10:20:15 INFO - Return code: 0 10:20:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:20:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:20:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/baf207cdfc8b9d9e28d0d5c3036a0b9a2f67a591303dc8b26e765e5f1a17c3800d9cc73096c35f3cd940a4ff2d6304885389b4fb5b95a3aaa9d381d8ca40e6e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e9c566d6ad9983b2bde28283e5d1ae9649d3ca773851e856bdae8afa2ae976c01d8311c3c2702bf6362b0412962c30732ada9c5ad10155b40d9cd6567d2a18a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fff31198f1229d335b4fae4d1d3b73b380ad3059339fd5f7b6525946035ce3c8b2e06d68736feaeedc25c4d7ae06005b65cb66acefcd55fe26c8a3e68f908e7"} 10:20:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:20:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:20:15 INFO - Contents: 10:20:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/baf207cdfc8b9d9e28d0d5c3036a0b9a2f67a591303dc8b26e765e5f1a17c3800d9cc73096c35f3cd940a4ff2d6304885389b4fb5b95a3aaa9d381d8ca40e6e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e9c566d6ad9983b2bde28283e5d1ae9649d3ca773851e856bdae8afa2ae976c01d8311c3c2702bf6362b0412962c30732ada9c5ad10155b40d9cd6567d2a18a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fff31198f1229d335b4fae4d1d3b73b380ad3059339fd5f7b6525946035ce3c8b2e06d68736feaeedc25c4d7ae06005b65cb66acefcd55fe26c8a3e68f908e7"} 10:20:15 INFO - Running post-run listener: copy_logs_to_upload_dir 10:20:15 INFO - Copying logs to upload dir... 10:20:15 INFO - mkdir: /builds/slave/test/build/upload/logs 10:20:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.765820 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-31 10:20:15.074732) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 10:20:15.079595) ========= 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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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/baf207cdfc8b9d9e28d0d5c3036a0b9a2f67a591303dc8b26e765e5f1a17c3800d9cc73096c35f3cd940a4ff2d6304885389b4fb5b95a3aaa9d381d8ca40e6e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e9c566d6ad9983b2bde28283e5d1ae9649d3ca773851e856bdae8afa2ae976c01d8311c3c2702bf6362b0412962c30732ada9c5ad10155b40d9cd6567d2a18a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fff31198f1229d335b4fae4d1d3b73b380ad3059339fd5f7b6525946035ce3c8b2e06d68736feaeedc25c4d7ae06005b65cb66acefcd55fe26c8a3e68f908e7"} build_url:https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010955 build_url: 'https://queue.taskcluster.net/v1/task/BDkoN0AqTv6fu-1B9juKSA/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/baf207cdfc8b9d9e28d0d5c3036a0b9a2f67a591303dc8b26e765e5f1a17c3800d9cc73096c35f3cd940a4ff2d6304885389b4fb5b95a3aaa9d381d8ca40e6e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9e9c566d6ad9983b2bde28283e5d1ae9649d3ca773851e856bdae8afa2ae976c01d8311c3c2702bf6362b0412962c30732ada9c5ad10155b40d9cd6567d2a18a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fff31198f1229d335b4fae4d1d3b73b380ad3059339fd5f7b6525946035ce3c8b2e06d68736feaeedc25c4d7ae06005b65cb66acefcd55fe26c8a3e68f908e7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 10:20:15.116287) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 10:20:15.116605) ========= 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.EBOfNR9xuc/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.k4RHCIXWJJ/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.004583 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 10:20:15.164754) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 10:20:15.165055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 10:20:15.167365) ========= ========= Total master_lag: 0.20 =========