builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0106 starttime: 1475598734.92 results: success (0) buildid: 20161004072900 builduid: 2066f9370eaa47a98838c04b9483d609 revision: 47615f092e09d8d37d883ca72e35891b242a5d4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:14.923129) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:14.923582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:14.923877) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:14.947277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:14.947667) ========= 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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 --2016-10-04 09:32: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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.55M=0.001s 2016-10-04 09:32:15 (8.55 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:15.102214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:15.102533) ========= 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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.021312 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:15.151841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 09:32:15.152242) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47615f092e09d8d37d883ca72e35891b242a5d4a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 47615f092e09d8d37d883ca72e35891b242a5d4a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9sjvQAVDzk/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.rwoTD1JSLN/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 2016-10-04 09:32:15,219 truncating revision to first 12 chars 2016-10-04 09:32:15,219 Setting DEBUG logging. 2016-10-04 09:32:15,220 attempt 1/10 2016-10-04 09:32:15,220 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47615f092e09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 09:32:16,899 unpacking tar archive at: fx-team-47615f092e09/testing/mozharness/ program finished with exit code 0 elapsedTime=1.950006 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 09:32:17.124934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:17.125260) ========= script_repo_revision: 47615f092e09d8d37d883ca72e35891b242a5d4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:17.125645) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:17.125931) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 09:32:17.144558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-04 09:32:17.145027) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9sjvQAVDzk/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.rwoTD1JSLN/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:32:17 INFO - MultiFileLogger online at 20161004 09:32:17 in /builds/slave/test 09:32:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:32:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:17 INFO - {'append_to_log': False, 09:32:17 INFO - 'base_work_dir': '/builds/slave/test', 09:32:17 INFO - 'blob_upload_branch': 'Fx-Team', 09:32:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:17 INFO - 'branch': 'Fx-Team', 09:32:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:17 INFO - 'config_files': ('talos/mac_config.py',), 09:32:17 INFO - 'default_actions': ('clobber', 09:32:17 INFO - 'read-buildbot-config', 09:32:17 INFO - 'download-and-extract', 09:32:17 INFO - 'populate-webroot', 09:32:17 INFO - 'create-virtualenv', 09:32:17 INFO - 'install', 09:32:17 INFO - 'run-tests'), 09:32:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:17 INFO - 'download_minidump_stackwalk': True, 09:32:17 INFO - 'download_symbols': 'ondemand', 09:32:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:17 INFO - 'installer_path': 'installer.exe', 09:32:17 INFO - 'log_level': 'info', 09:32:17 INFO - 'log_name': 'talos', 09:32:17 INFO - 'log_to_console': True, 09:32:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:32:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:32:17 INFO - 'opt_config_files': (), 09:32:17 INFO - 'pip_index': False, 09:32:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:32:17 INFO - 'cmd': ('bash', 09:32:17 INFO - '-c', 09:32:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:32:17 INFO - 'enabled': True, 09:32:17 INFO - 'halt_on_failure': False, 09:32:17 INFO - 'name': 'check_screen_resolution'},), 09:32:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:32:17 INFO - 'cmd': ('bash', 09:32:17 INFO - '-c', 09:32:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:32:17 INFO - 'enabled': True, 09:32:17 INFO - 'halt_on_failure': False, 09:32:17 INFO - 'name': 'check_screen_resolution'},), 09:32:17 INFO - 'run_cmd_checks_enabled': True, 09:32:17 INFO - 'sps_profile': False, 09:32:17 INFO - 'sps_profile_interval': 0, 09:32:17 INFO - 'suite': 'dromaeojs', 09:32:17 INFO - 'system_bits': '32', 09:32:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:17 INFO - 'title': 't-yosemite-r7-0106', 09:32:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:17 INFO - 'use_talos_json': True, 09:32:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:17 INFO - 'work_dir': 'build'} 09:32:17 INFO - [mozharness: 2016-10-04 16:32:17.354432Z] Running clobber step. 09:32:17 INFO - Running pre-action listener: _resource_record_pre_action 09:32:17 INFO - Running main action method: clobber 09:32:17 INFO - rmtree: /builds/slave/test/build 09:32:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:32:18 INFO - Running post-action listener: _resource_record_post_action 09:32:18 INFO - [mozharness: 2016-10-04 16:32:18.949854Z] Finished clobber step (success) 09:32:18 INFO - [mozharness: 2016-10-04 16:32:18.950070Z] Running read-buildbot-config step. 09:32:18 INFO - Running pre-action listener: _resource_record_pre_action 09:32:18 INFO - Running main action method: read_buildbot_config 09:32:18 INFO - Using buildbot properties: 09:32:18 INFO - { 09:32:18 INFO - "project": "", 09:32:18 INFO - "product": "firefox", 09:32:18 INFO - "script_repo_revision": "production", 09:32:18 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:32:18 INFO - "repository": "", 09:32:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:32:18 INFO - "buildid": "20161004072900", 09:32:18 INFO - "pgo_build": "False", 09:32:18 INFO - "basedir": "/builds/slave/test", 09:32:18 INFO - "buildnumber": 7, 09:32:18 INFO - "slavename": "t-yosemite-r7-0106", 09:32:18 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:32:18 INFO - "platform": "yosemite_r7", 09:32:18 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:32:18 INFO - "branch": "fx-team", 09:32:18 INFO - "repo_path": "integration/fx-team", 09:32:18 INFO - "revision": "47615f092e09d8d37d883ca72e35891b242a5d4a", 09:32:18 INFO - "stage_platform": "macosx64", 09:32:18 INFO - "builduid": "2066f9370eaa47a98838c04b9483d609", 09:32:18 INFO - "slavebuilddir": "test" 09:32:18 INFO - } 09:32:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:32:18 INFO - Running post-action listener: _resource_record_post_action 09:32:18 INFO - [mozharness: 2016-10-04 16:32:18.955089Z] Finished read-buildbot-config step (success) 09:32:18 INFO - [mozharness: 2016-10-04 16:32:18.955304Z] Running download-and-extract step. 09:32:18 INFO - Running pre-action listener: _resource_record_pre_action 09:32:18 INFO - Running main action method: download_and_extract 09:32:18 INFO - mkdir: /builds/slave/test/build/tests 09:32:18 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:32:18 INFO - trying https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:32:18 INFO - Downloading https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 09:32:20 INFO - Downloaded 1199 bytes. 09:32:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:32:20 INFO - Using the following test package requirements: 09:32:20 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:32:20 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:32:20 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:32:20 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:32:20 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:32:20 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:32:20 INFO - u'jsshell-mac.zip'], 09:32:20 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:32:20 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:32:20 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:32:20 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:32:20 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:32:20 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:32:20 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:32:20 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:32:20 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:32:20 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:32:20 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:32:20 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:32:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:32:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:32:20 INFO - Fetch https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:32:21 INFO - Http code: 200 09:32:21 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 09:32:21 INFO - x-amz-cf-id: wAptZak-WU1OPbgVTbdhN6IAqKeZJjAwweCnK5myj_vJllLW2zJcWQ== 09:32:21 INFO - x-amz-version-id: OpVZKtmTTfVZbcMDEMv61mXMea_hUI3B 09:32:21 INFO - Expected file size: 16476845 09:32:21 INFO - Obtained file size: 16476845 09:32:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:32:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:32:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:32:28 INFO - Fetch https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:32:28 INFO - Http code: 200 09:32:28 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 09:32:28 INFO - x-amz-cf-id: 9x6MQOGT4-AYK7x91JdxR1uOEjTHHOZze11NoJvQp2lxm2Zg2-t3NQ== 09:32:28 INFO - x-amz-version-id: OpVZKtmTTfVZbcMDEMv61mXMea_hUI3B 09:32:29 INFO - Expected file size: 16476845 09:32:29 INFO - Obtained file size: 16476845 09:32:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:32:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:32:35 INFO - Fetch https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:32:35 INFO - Http code: 200 09:32:35 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 09:32:35 INFO - x-amz-cf-id: pg2eZoC5qa0I_-7y5elTu_Hn3CWxRpHlr-yut7N1V3OooqLI7adHhw== 09:32:35 INFO - x-amz-version-id: VK2VdJmlE8qudTtMm6EpiqQ9iUR2E0Bb 09:32:36 INFO - Expected file size: 14409006 09:32:36 INFO - Obtained file size: 14409006 09:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:36 INFO - trying https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:32:36 INFO - Downloading https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 09:32:39 INFO - Downloaded 111609098 bytes. 09:32:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:32:39 INFO - mkdir: /builds/slave/test/properties 09:32:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:32:39 INFO - Writing to file /builds/slave/test/properties/build_url 09:32:39 INFO - Contents: 09:32:39 INFO - build_url:https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:32:39 INFO - Running post-action listener: _resource_record_post_action 09:32:39 INFO - Running post-action listener: set_extra_try_arguments 09:32:39 INFO - [mozharness: 2016-10-04 16:32:39.971626Z] Finished download-and-extract step (success) 09:32:39 INFO - [mozharness: 2016-10-04 16:32:39.971764Z] Running populate-webroot step. 09:32:39 INFO - Running pre-action listener: _resource_record_pre_action 09:32:39 INFO - Running main action method: populate_webroot 09:32:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:32:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:32:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:32:39 INFO - '--tppagecycles', 09:32:39 INFO - '7'], 09:32:39 INFO - 'tests': ['tsvgm']}}, 09:32:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:32:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:32:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:32:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:32:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['damp', 'tps']}, 09:32:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'tests': ['damp', 'tps']}, 09:32:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['dromaeo_dom']}, 09:32:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:32:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['basic_compositor_video']}, 09:32:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:32:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'other-e10s': {'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['a11yr', 09:32:39 INFO - 'ts_paint', 09:32:39 INFO - 'tpaint', 09:32:39 INFO - 'sessionrestore', 09:32:39 INFO - 'sessionrestore_no_auto_restore', 09:32:39 INFO - 'tabpaint']}, 09:32:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['tsvgx', 09:32:39 INFO - 'tsvgr_opacity', 09:32:39 INFO - 'tart', 09:32:39 INFO - 'tscrollx', 09:32:39 INFO - 'cart']}, 09:32:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:32:39 INFO - 'tsvgr_opacity', 09:32:39 INFO - 'tart', 09:32:39 INFO - 'tscrollx', 09:32:39 INFO - 'cart']}, 09:32:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'talos_options': ['--disable-e10s'], 09:32:39 INFO - 'tests': ['tp5o']}, 09:32:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'tests': ['tp5o']}, 09:32:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'talos_options': ['--disable-e10s', 09:32:39 INFO - '--xperf_path', 09:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:39 INFO - 'tests': ['tp5n']}, 09:32:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:39 INFO - 'talos_options': ['--xperf_path', 09:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:39 INFO - 'tests': ['tp5n']}}, 09:32:39 INFO - 'talos.zip': {'path': '', 09:32:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:32:39 INFO - Running post-action listener: _resource_record_post_action 09:32:39 INFO - [mozharness: 2016-10-04 16:32:39.990524Z] Finished populate-webroot step (success) 09:32:39 INFO - [mozharness: 2016-10-04 16:32:39.990657Z] Running create-virtualenv step. 09:32:39 INFO - Running pre-action listener: _resource_record_pre_action 09:32:39 INFO - Running main action method: create_virtualenv 09:32:39 INFO - Creating virtualenv /builds/slave/test/build/venv 09:32:39 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:32:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:32:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:32:40 INFO - Using real prefix '/tools/python27' 09:32:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:32:40 INFO - Installing distribute.............................................................................................................................................................................................done. 09:32:43 INFO - Installing pip.................done. 09:32:43 INFO - Return code: 0 09:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:32:43 INFO - Reading from file tmpfile_stdout 09:32:43 INFO - Output received: 09:32:43 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:32:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:32:43 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:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:43 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:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:43 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 0x102450490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb552d77d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, '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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:32:43 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:32:43 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:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:43 INFO - 'HOME': '/Users/cltbld', 09:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:43 INFO - 'LOGNAME': 'cltbld', 09:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:43 INFO - 'MOZ_NO_REMOTE': '1', 09:32:43 INFO - 'NO_EM_RESTART': '1', 09:32:43 INFO - 'PAGER': '/bin/cat', 09:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:43 INFO - 'PWD': '/builds/slave/test', 09:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:43 INFO - 'SHELL': '/bin/bash', 09:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:32:43 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:43 INFO - 'USER': 'cltbld', 09:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:43 INFO - 'XPC_FLAGS': '0x0', 09:32:43 INFO - 'XPC_SERVICE_NAME': '0', 09:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:44 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:32:44 INFO - Cleaning up... 09:32:44 INFO - Return code: 0 09:32:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:32:44 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:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:44 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:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:44 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 0x102450490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb552d77d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, '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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:32:44 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:32:44 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:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:44 INFO - 'HOME': '/Users/cltbld', 09:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:44 INFO - 'LOGNAME': 'cltbld', 09:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:44 INFO - 'MOZ_NO_REMOTE': '1', 09:32:44 INFO - 'NO_EM_RESTART': '1', 09:32:44 INFO - 'PAGER': '/bin/cat', 09:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:44 INFO - 'PWD': '/builds/slave/test', 09:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:44 INFO - 'SHELL': '/bin/bash', 09:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:32:44 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:44 INFO - 'USER': 'cltbld', 09:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:44 INFO - 'XPC_FLAGS': '0x0', 09:32:44 INFO - 'XPC_SERVICE_NAME': '0', 09:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:44 INFO - Downloading/unpacking psutil>=3.1.1 09:32:44 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:32:44 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:32:44 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:32:44 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:32:44 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:32:44 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:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:32:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:47 INFO - Installing collected packages: psutil 09:32:47 INFO - Running setup.py install for psutil 09:32:47 INFO - building 'psutil._psutil_osx' extension 09:32:47 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:32:48 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:32:48 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:32:48 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:32:48 INFO - building 'psutil._psutil_posix' extension 09:32:48 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:32:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:32:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:32:48 INFO - ^ 09:32:48 INFO - 1 warning generated. 09:32:48 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:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:48 INFO - Successfully installed psutil 09:32:48 INFO - Cleaning up... 09:32:48 INFO - Return code: 0 09:32:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:32:48 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:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:48 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:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:48 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 0x102450490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb552d77d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, '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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:32:48 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:32:48 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:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:48 INFO - 'HOME': '/Users/cltbld', 09:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:48 INFO - 'LOGNAME': 'cltbld', 09:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:48 INFO - 'MOZ_NO_REMOTE': '1', 09:32:48 INFO - 'NO_EM_RESTART': '1', 09:32:48 INFO - 'PAGER': '/bin/cat', 09:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:48 INFO - 'PWD': '/builds/slave/test', 09:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:48 INFO - 'SHELL': '/bin/bash', 09:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:32:48 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:48 INFO - 'USER': 'cltbld', 09:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:48 INFO - 'XPC_FLAGS': '0x0', 09:32:48 INFO - 'XPC_SERVICE_NAME': '0', 09:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:32:48 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:32:48 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:32:48 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:32:48 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:32:48 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:32:48 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:32:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:32:51 INFO - Installing collected packages: mozsystemmonitor 09:32:51 INFO - Running setup.py install for mozsystemmonitor 09:32:51 INFO - Successfully installed mozsystemmonitor 09:32:51 INFO - Cleaning up... 09:32:51 INFO - Return code: 0 09:32:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:32:51 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:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 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:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 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 0x102450490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb552d77d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, '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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:32:51 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:32:51 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:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:51 INFO - 'HOME': '/Users/cltbld', 09:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:51 INFO - 'LOGNAME': 'cltbld', 09:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:51 INFO - 'MOZ_NO_REMOTE': '1', 09:32:51 INFO - 'NO_EM_RESTART': '1', 09:32:51 INFO - 'PAGER': '/bin/cat', 09:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:51 INFO - 'PWD': '/builds/slave/test', 09:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:51 INFO - 'SHELL': '/bin/bash', 09:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:32:51 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:51 INFO - 'USER': 'cltbld', 09:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:51 INFO - 'XPC_FLAGS': '0x0', 09:32:51 INFO - 'XPC_SERVICE_NAME': '0', 09:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:51 INFO - Downloading/unpacking jsonschema==2.5.1 09:32:51 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:32:51 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:32:51 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:32:51 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:32:51 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:32:51 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:32:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:32:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:32: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:32: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:32: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:32: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:32: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:32: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:32:54 INFO - Downloading functools32-3.2.3-2.tar.gz 09:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:32:54 INFO - warning: no files found matching '*.txt' 09:32:54 INFO - no previously-included directories found matching 'build' 09:32:54 INFO - no previously-included directories found matching 'dist' 09:32:54 INFO - no previously-included directories found matching '.git*' 09:32:54 INFO - Installing collected packages: jsonschema, functools32 09:32:54 INFO - Running setup.py install for functools32 09:32:55 INFO - warning: no files found matching '*.txt' 09:32:55 INFO - no previously-included directories found matching 'build' 09:32:55 INFO - no previously-included directories found matching 'dist' 09:32:55 INFO - no previously-included directories found matching '.git*' 09:32:55 INFO - Successfully installed jsonschema functools32 09:32:55 INFO - Cleaning up... 09:32:55 INFO - Return code: 0 09:32:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:32:55 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:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:55 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:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:55 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 0x102450490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb552d77d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, '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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:32:55 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:32:55 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:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:55 INFO - 'HOME': '/Users/cltbld', 09:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:55 INFO - 'LOGNAME': 'cltbld', 09:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:55 INFO - 'MOZ_NO_REMOTE': '1', 09:32:55 INFO - 'NO_EM_RESTART': '1', 09:32:55 INFO - 'PAGER': '/bin/cat', 09:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:55 INFO - 'PWD': '/builds/slave/test', 09:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:55 INFO - 'SHELL': '/bin/bash', 09:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:32:55 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:55 INFO - 'USER': 'cltbld', 09:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:55 INFO - 'XPC_FLAGS': '0x0', 09:32:55 INFO - 'XPC_SERVICE_NAME': '0', 09:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:32:55 INFO - Cleaning up... 09:32:55 INFO - Return code: 0 09:32:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:32:55 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:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:55 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:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:55 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 0x102450490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb552d77d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, '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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:32:55 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:32:55 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:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:55 INFO - 'HOME': '/Users/cltbld', 09:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:55 INFO - 'LOGNAME': 'cltbld', 09:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:55 INFO - 'MOZ_NO_REMOTE': '1', 09:32:55 INFO - 'NO_EM_RESTART': '1', 09:32:55 INFO - 'PAGER': '/bin/cat', 09:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:55 INFO - 'PWD': '/builds/slave/test', 09:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:55 INFO - 'SHELL': '/bin/bash', 09:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:32:55 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:55 INFO - 'USER': 'cltbld', 09:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:55 INFO - 'XPC_FLAGS': '0x0', 09:32:55 INFO - 'XPC_SERVICE_NAME': '0', 09:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:55 INFO - Downloading/unpacking blobuploader==1.2.4 09:32:55 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:32:55 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:32:55 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:32:55 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:32:55 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:32:55 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:32:58 INFO - Downloading blobuploader-1.2.4.tar.gz 09:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:32:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:32:58 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:32:58 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:32:58 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:32:58 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:32:58 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:32:58 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:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32:58 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:32:58 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:32:58 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:32:58 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:32:58 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:32:58 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:32:59 INFO - Downloading docopt-0.6.1.tar.gz 09:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:59 INFO - Running setup.py install for blobuploader 09:32:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:59 INFO - Running setup.py install for requests 09:33:00 INFO - Running setup.py install for docopt 09:33:00 INFO - Successfully installed blobuploader requests docopt 09:33:00 INFO - Cleaning up... 09:33:00 INFO - Return code: 0 09:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:00 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:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 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:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 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 0x102450490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb552d77d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, '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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:33:00 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:33:00 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:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:00 INFO - 'HOME': '/Users/cltbld', 09:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:00 INFO - 'LOGNAME': 'cltbld', 09:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:00 INFO - 'MOZ_NO_REMOTE': '1', 09:33:00 INFO - 'NO_EM_RESTART': '1', 09:33:00 INFO - 'PAGER': '/bin/cat', 09:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:00 INFO - 'PWD': '/builds/slave/test', 09:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:00 INFO - 'SHELL': '/bin/bash', 09:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:33:00 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:00 INFO - 'USER': 'cltbld', 09:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:00 INFO - 'XPC_FLAGS': '0x0', 09:33:00 INFO - 'XPC_SERVICE_NAME': '0', 09:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:00 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ab1INj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:00 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Khp0Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:00 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xGPrHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-IlFJsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-spOcuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zqDb0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-hYdysd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-AFWcNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xMMVQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-lnV6xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-w7Zxlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:01 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-c7UjoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-81iBse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-_Nk65Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-sHUDpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-VEUysX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:02 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-39_0tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:02 INFO - Running setup.py install for manifestparser 09:33:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:02 INFO - Running setup.py install for mozcrash 09:33:02 INFO - Running setup.py install for mozdebug 09:33:02 INFO - Running setup.py install for mozdevice 09:33:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Running setup.py install for mozfile 09:33:03 INFO - Running setup.py install for mozhttpd 09:33:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Running setup.py install for mozinfo 09:33:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Running setup.py install for mozInstall 09:33:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Running setup.py install for mozleak 09:33:03 INFO - Running setup.py install for mozlog 09:33:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:04 INFO - Running setup.py install for moznetwork 09:33:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:04 INFO - Running setup.py install for mozprocess 09:33:04 INFO - Running setup.py install for mozprofile 09:33:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:04 INFO - Running setup.py install for mozrunner 09:33:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:04 INFO - Running setup.py install for mozscreenshot 09:33:04 INFO - Running setup.py install for moztest 09:33:04 INFO - Running setup.py install for mozversion 09:33:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:05 INFO - Cleaning up... 09:33:05 INFO - Return code: 0 09:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:05 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:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:05 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:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:05 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 0x102450490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb552d77d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, '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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:33:05 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 09:33:05 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 09:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:05 INFO - 'HOME': '/Users/cltbld', 09:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:05 INFO - 'LOGNAME': 'cltbld', 09:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:05 INFO - 'MOZ_NO_REMOTE': '1', 09:33:05 INFO - 'NO_EM_RESTART': '1', 09:33:05 INFO - 'PAGER': '/bin/cat', 09:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:05 INFO - 'PWD': '/builds/slave/test', 09:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:05 INFO - 'SHELL': '/bin/bash', 09:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:33:05 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:05 INFO - 'USER': 'cltbld', 09:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:05 INFO - 'XPC_FLAGS': '0x0', 09:33:05 INFO - 'XPC_SERVICE_NAME': '0', 09:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:05 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-5bw_wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:05 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ijujOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:05 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-l8GMVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:05 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-CbTxlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:05 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-7YDgof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:05 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-LxcHqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:06 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-LfLMM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:06 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-gdHROl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:06 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-0VsnfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:06 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xjWjbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:06 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Yh4Wiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:06 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-RR7K05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:06 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-X5f6Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:06 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-nMOGXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:06 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Q41Yr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:06 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ts9A3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:07 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zHAY6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:07 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)) 09:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:07 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)) 09:33:07 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)) 09:33:07 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)) 09:33:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:09 INFO - Downloading blessings-1.6.tar.gz 09:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:09 INFO - Installing collected packages: blessings 09:33:09 INFO - Running setup.py install for blessings 09:33:09 INFO - Successfully installed blessings 09:33:09 INFO - Cleaning up... 09:33:09 INFO - Return code: 0 09:33:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:10 INFO - Reading from file tmpfile_stdout 09:33:10 INFO - Current package versions: 09:33:10 INFO - blessings == 1.6 09:33:10 INFO - blobuploader == 1.2.4 09:33:10 INFO - docopt == 0.6.1 09:33:10 INFO - functools32 == 3.2.3-2 09:33:10 INFO - jsonschema == 2.5.1 09:33:10 INFO - manifestparser == 1.1 09:33:10 INFO - mozInstall == 1.12 09:33:10 INFO - mozcrash == 0.17 09:33:10 INFO - mozdebug == 0.1 09:33:10 INFO - mozdevice == 0.48 09:33:10 INFO - mozfile == 1.2 09:33:10 INFO - mozhttpd == 0.7 09:33:10 INFO - mozinfo == 0.9 09:33:10 INFO - mozleak == 0.1 09:33:10 INFO - mozlog == 3.4 09:33:10 INFO - moznetwork == 0.27 09:33:10 INFO - mozprocess == 0.23 09:33:10 INFO - mozprofile == 0.28 09:33:10 INFO - mozrunner == 6.12 09:33:10 INFO - mozscreenshot == 0.1 09:33:10 INFO - mozsystemmonitor == 0.3 09:33:10 INFO - moztest == 0.7 09:33:10 INFO - mozversion == 1.4 09:33:10 INFO - psutil == 3.1.1 09:33:10 INFO - requests == 1.2.3 09:33:10 INFO - wsgiref == 0.1.2 09:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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 0x102450490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb552d77d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, '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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:33: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 09:33: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 09:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:10 INFO - 'HOME': '/Users/cltbld', 09:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:10 INFO - 'LOGNAME': 'cltbld', 09:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:10 INFO - 'MOZ_NO_REMOTE': '1', 09:33:10 INFO - 'NO_EM_RESTART': '1', 09:33:10 INFO - 'PAGER': '/bin/cat', 09:33:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:10 INFO - 'PWD': '/builds/slave/test', 09:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:10 INFO - 'SHELL': '/bin/bash', 09:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:33:10 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:10 INFO - 'USER': 'cltbld', 09:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:10 INFO - 'XPC_FLAGS': '0x0', 09:33:10 INFO - 'XPC_SERVICE_NAME': '0', 09:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33: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)) 09:33: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)) 09:33: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)) 09:33: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)) 09:33: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)) 09:33: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)) 09:33: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)) 09:33: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)) 09:33: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)) 09:33: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)) 09:33: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)) 09:33:10 INFO - Cleaning up... 09:33:10 INFO - Return code: 0 09:33:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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 0x102450490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023c6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb552d77d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, '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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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:33: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 09:33: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 09:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:10 INFO - 'HOME': '/Users/cltbld', 09:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:10 INFO - 'LOGNAME': 'cltbld', 09:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:10 INFO - 'MOZ_NO_REMOTE': '1', 09:33:10 INFO - 'NO_EM_RESTART': '1', 09:33:10 INFO - 'PAGER': '/bin/cat', 09:33:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:10 INFO - 'PWD': '/builds/slave/test', 09:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:10 INFO - 'SHELL': '/bin/bash', 09:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:33:10 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:10 INFO - 'USER': 'cltbld', 09:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:10 INFO - 'XPC_FLAGS': '0x0', 09:33:10 INFO - 'XPC_SERVICE_NAME': '0', 09:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:10 INFO - Cleaning up... 09:33:10 INFO - Return code: 0 09:33:10 INFO - Running post-action listener: _resource_record_post_action 09:33:10 INFO - Running post-action listener: _start_resource_monitoring 09:33:10 INFO - Starting resource monitoring. 09:33:10 INFO - [mozharness: 2016-10-04 16:33:10.824164Z] Finished create-virtualenv step (success) 09:33:10 INFO - [mozharness: 2016-10-04 16:33:10.825231Z] Running install step. 09:33:10 INFO - Running pre-action listener: _resource_record_pre_action 09:33:10 INFO - Running main action method: install 09:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:11 INFO - Reading from file tmpfile_stdout 09:33:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:11 INFO - Reading from file tmpfile_stdout 09:33:11 INFO - Output received: 09:33:11 INFO - Usage: mozinstall [options] installer 09:33:11 INFO - Options: 09:33:11 INFO - -h, --help show this help message and exit 09:33:11 INFO - -d DEST, --destination=DEST 09:33:11 INFO - Directory to install application into. [default: 09:33:11 INFO - "/builds/slave/test"] 09:33:11 INFO - --app=APP Application being installed. [default: firefox] 09:33:11 INFO - mkdir: /builds/slave/test/build/application 09:33:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:33:45 INFO - Reading from file tmpfile_stdout 09:33:45 INFO - Output received: 09:33:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:33:45 INFO - Running post-action listener: _resource_record_post_action 09:33:45 INFO - [mozharness: 2016-10-04 16:33:45.513399Z] Finished install step (success) 09:33:45 INFO - [mozharness: 2016-10-04 16:33:45.513536Z] Running run-tests step. 09:33:45 INFO - Running pre-action listener: _resource_record_pre_action 09:33:45 INFO - Running main action method: run_tests 09:33:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:33:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:33:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:33:45 INFO - 2016-10-04 09:33:45.528 screenresolution[1926:11995] starting screenresolution argv=screenresolution get 09:33:45 INFO - 2016-10-04 09:33:45.531 screenresolution[1926:11995] Display 0: 1600x1200x32@60 09:33:45 INFO - 2016-10-04 09:33:45.536 screenresolution[1927:11997] starting screenresolution argv=screenresolution list 09:33:45 INFO - Available Modes on Display 0 09:33:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:33:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:33:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:33:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:33:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:33:45 INFO - Intel Iris: 09:33:45 INFO - Chipset Model: Intel Iris 09:33:45 INFO - Type: GPU 09:33:45 INFO - Bus: Built-In 09:33:45 INFO - VRAM (Dynamic, Max): 1536 MB 09:33:45 INFO - Vendor: Intel (0x8086) 09:33:45 INFO - Device ID: 0x0a2e 09:33:45 INFO - Revision ID: 0x0009 09:33:45 INFO - Displays: 09:33:45 INFO - Display: 09:33:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:33:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:33:45 INFO - Display Serial Number: 1600x1200 60 09:33:45 INFO - Main Display: Yes 09:33:45 INFO - Mirror: Off 09:33:45 INFO - Online: Yes 09:33:45 INFO - Rotation: Supported 09:33:45 INFO - Return code: 0 09:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:45 INFO - Python 2.7.3 09:33:45 INFO - Return code: 0 09:33:45 INFO - grabbing minidump binary from tooltool 09:33:45 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:33:45 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 0x102264d30>, '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 0x10208adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10225cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:45 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 09:33:45 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 09:33:45 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 09:33:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:45 INFO - Return code: 0 09:33:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:33:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:33:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 09:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 09:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9sjvQAVDzk/Render', 09:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:45 INFO - 'HOME': '/Users/cltbld', 09:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:45 INFO - 'LOGNAME': 'cltbld', 09:33:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:45 INFO - 'MOZ_NO_REMOTE': '1', 09:33:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:45 INFO - 'NO_EM_RESTART': '1', 09:33:45 INFO - 'PAGER': '/bin/cat', 09:33:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:45 INFO - 'PWD': '/builds/slave/test', 09:33:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:45 INFO - 'SHELL': '/bin/bash', 09:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rwoTD1JSLN/Listeners', 09:33:45 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 09:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:45 INFO - 'USER': 'cltbld', 09:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:45 INFO - 'XPC_FLAGS': '0x0', 09:33:45 INFO - 'XPC_SERVICE_NAME': '0', 09:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 09:33:46 INFO - mozversion application_buildid: 20161004072900 09:33:46 INFO - mozversion application_changeset: 47615f092e09d8d37d883ca72e35891b242a5d4a 09:33:46 INFO - mozversion application_display_name: Nightly 09:33:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:46 INFO - mozversion application_name: Firefox 09:33:46 INFO - mozversion application_remotingname: firefox 09:33:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:33:46 INFO - mozversion application_vendor: Mozilla 09:33:46 INFO - mozversion application_version: 52.0a1 09:33:46 INFO - mozversion platform_buildid: 20161004072900 09:33:46 INFO - mozversion platform_changeset: 47615f092e09d8d37d883ca72e35891b242a5d4a 09:33:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:33:46 INFO - mozversion platform_version: 52.0a1 09:33:46 INFO - using testdate: 1475598826 09:33:46 INFO - actual date: 1475598826 09:33:46 INFO - starting webserver on 'localhost:50886' 09:33:46 INFO - SUITE-START | Running 2 tests 09:33:46 INFO - TEST-START | dromaeo_css 09:33:46 INFO - operating with platform_type : mac_ 09:33:46 INFO - Initialising browser for dromaeo_css test... 09:33:46 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmplC_oP8/profile http://localhost:50886/getInfo.html) 09:33:48 INFO - PROCESS | 1937 | __metrics Screen width/height:1600/1200 09:33:48 INFO - PROCESS | 1937 | colorDepth:24 09:33:48 INFO - PROCESS | 1937 | Browser inner width/height: 1024/689 09:33:48 INFO - PROCESS | 1937 | __metrics 09:33:48 INFO - PROCESS | 1937 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:33:48 INFO - PROCESS | 1937 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:49 INFO - TEST-INFO | 1937: exit 0 09:33:49 INFO - Browser initialized. 09:33:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:33:49 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmplC_oP8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:01 INFO - PROCESS | 1939 | RSS: Main: 236089344 09:34:01 INFO - PROCESS | 1939 | 09:34:52 INFO - PROCESS | 1939 | 1475598892666 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:37:05 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50886/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50886/tests/dromaeo/cssquery-ext.html) 09:37:07 INFO - PROCESS | 1939 | RSS: Main: 387723264 09:37:07 INFO - PROCESS | 1939 | 09:40:09 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50886/tests/dromaeo/cssquery-ext.html (next: http://localhost:50886/tests/dromaeo/cssquery-jquery.html) 09:40:10 INFO - PROCESS | 1939 | RSS: Main: 376569856 09:40:10 INFO - PROCESS | 1939 | 09:43:12 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50886/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50886/tests/dromaeo/cssquery-mootools.html) 09:43:13 INFO - PROCESS | 1939 | RSS: Main: 334778368 09:43:13 INFO - PROCESS | 1939 | 09:46:15 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50886/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50886/tests/dromaeo/cssquery-prototype.html) 09:46:16 INFO - PROCESS | 1939 | RSS: Main: 350429184 09:46:16 INFO - PROCESS | 1939 | 09:49:20 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50886/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50886/tests/dromaeo/cssquery-yui.html) 09:49:20 INFO - PROCESS | 1939 | RSS: Main: 329584640 09:49:20 INFO - PROCESS | 1939 | 09:52:24 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:50886/tests/dromaeo/cssquery-yui.html (next: http://localhost:50886/tests/dromaeo/cssquery-dojo.html) 09:52:24 INFO - PROCESS | 1939 | RSS: Main: 480501760 09:52:24 INFO - PROCESS | 1939 | 09:52:24 INFO - PROCESS | 1939 | __start_tp_report 09:52:24 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 09:52:24 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 09:52:24 INFO - PROCESS | 1939 | |i|pagename|runs| 09:52:24 INFO - PROCESS | 1939 | |0;dojo.html;3271.6401195868457;3282.6224984126825;3297.0603378037263;3311.33773245351;3364.764466487347;5493.945060549393;5547.805826796058;5608.887822243558;5626.54987600992;5640.012997725397;5548.944510554903;5585.162225666152;5600.019996500606;5607.186957891104;5619.634723742954;5076.959223359212;5111.284420181159;5118.07874582575;5123.410807757118;5200.895982080356;5123.513266239701;5130.07658621448;5183.53348198662;5208.583313334924;5214.687118772867;4379.795556222032;5175.508326708976;5204.739763011853;5219.608529360313;5244.501772331622;5075.390953085616;5185.299984502081;5194.428612852583;5202.0896343140175;5269.789208431658;4295;4389.978050109761;4808;5105.668131571436;5156.432792392871;5527.55779537636;5530.308711411074;5577.749001294951;5582.609217354787;5588.385277619459;6087.147799308101;6102.511799056109;6106.358832322631;6111;6125.78559750411;6058.606190597641;6064;6102.610439773209;6113.602615829956;6189.102580125901;5653.180288858133;5690;5691.430856914276;5692.889886472181;5717.542596592304;6309.589876658002;6316.810495685045;6319.52603554726;6319.842003949938;6329.525285603599;5842.561807864342;5905.822825315247;5919.4968427684125;5984.3417224105315;5988;6128.78549250783;6130.948521380002;6156.661383623944;6189;6191.845203869849;6074.696265186723;6095.030038230458;6099.521645064548;6111.40942266768;6115.850337076409;5949.196858424144;6057.182280392179;6131.325554189036;6145.324014358417;6170.074488826622;4789.4971028042255;4814.446338671098;4822.107910036654;4824.541668541483;4827.61379089672;4317.373980772833;4322.913541729148;4349.630281426051;4361.214981303396;4445.377647129404;5690.715464226772;5717;5719.971400143056;5727.942720572741;5733.88532229353;6179.567430279927;6205.317415084337;6207.379262073757;6216.875662486816;6232.815765004634;5670.829875103671;5683.403242659544;5683.857903552362;5692.459216374438;5695.686737229492;4958.727270000185;5168.948310516922;5192.61055420845;5251.894962100737;5298.70857102863;6265.655388953652;6306.432421082033;6341.4609758170145;6345.460635845912;6350.936490635035;6176.382361763787;6178;6184.257889053162;6190.164327815687;6194.287656919331;6156.445919867055;6168.920438923081;6239.875202495834;6311.652859092794;6325.304216536269;6039.154518367344;6069.453749162597;6080.635161890301;6111.480524155497;6129.141920131096;6130.005417306534;6164.229471316085;6184.350643182401;6184.81445556634;6201.596896201732;5472.945270547243;5524.66851988882;5552.305961754781;5902.586818922634;5970;5516.641418307797;5873.530117590668;5875.676837773793;5924.733386997682;5996.730147143302;4999.225120106389;5585.134304182858;5793.362730099601;5807.738651760596;5835.766569337349;5008.974955125201;5939.376365481735;5943.138244954544;5953.434423729739;5967.910481342697;5624.521915637053;5730.684812335361;5762.049261871744;5763.221965034834;5826.504747096545 09:52:24 INFO - PROCESS | 1939 | |1;ext.html;460.3049395412926;481.62433302024414;529.2009066309873;542.235448018294;547.1710358806406;30548.847255763718;31614.841925790366;33824.49263261053;39829.60170398295;43631;42333.7883310583;42493;42842.35736463948;42852.71441856749;42901.78549107258;9710.563024663907;9893.802123957517;9894.505274736235;9909.653162139326;9921;9687.273454490942;9797.314188006842;9799.069088436587;9799.16707079899;9800.901990980106;9801.41191528507;9810.509474526281;9829.213662906986;9847.556859941284;9864.210863130933;9729.270304727139;9793.510324483746;9808.607655693764;9810.90189098107;9812.165965892871;9715.36850104741;9740.610375585038;9741.710697985967;9753.122219000254;9776.266779991458;40730.38904416436;41030.79484602588;41136.79431602853;41158.58841411577;41178.9705257368;3295.670432956709;3314.287428202948;3347.581552305962;3380.8985730428126;3381.408253555618;30666.693333066607;31076.844615776776;31496.685033149603;32205.194870128435;32214.355712885612;3167.160702413862;3187.378461200067;3224.226185715435;3328.766986310959;3333.183370074323;298499;302926.485367574;303227;303367;303386;59185.52036199129;60211.39788602058;63759;64710;64787.67606161939;32947;33223.00330990074;33321.50017749736;68026.319736802;69415;16013.439529616408;16357.427490037791;16418.26117824701;16426.342946282013;16454;12367.876321236852;12462.501499940083;12478.688032799253;12482.188657737219;12484.50061997528;16713.91643041777;20370.555533336094;20568;20620;20686;8643.35174861888;8727.60725767342;8737.606807693543;8750.606222719993;8839.646414143492;855.4012191465998;950.1306304731231;1028.9588416463407;1035.6634093919506;1077.8922107789158;23029.88485057564;29098.98153564615;29694.257643559085;30411.543826842615;30453.69546304553;1035.7928414317166;1037.0977249792577;1057.7144171073767;1068.7808999155154;1105.5577768892508;14909;15458.995165314444;15530.115974560418;15717.842821571638;15892.364305427885;686413;689812;690558;690666;691699;57654.13518797221;58081.70959145177;58127.41872581305;58192;58441;1314.4807800918584;1362.8160198373093;1379.3999610169608;1380.8527739365184;1381.5579014715395;23995.040198391867;24668.259952201464;29760.10719678413;29930.85034574813;30130.480427935985;49704;50052.499475004784;50198;50225;50351.49648503468;592403;593876;594373;594698.0265098647;595109;27035.324116897234;27122.457550849267;27394.31514212081;27456.45087098287;27541;46979.29531056969;47319.05361892812;48388;48443.5155648439;48750.26874596955;39305.41041884317;39344.01639959024;39501.2099758009;39503.60496394999;40852.59147408607;38475.615243847205;38876;40201.39697904475;40264.7986760076;40651.59348406478;37478;37584.62415375921;38588.22823543457;38741.80629096949;38883.2223355537;32540;32595.295823230364;32718.018459446255;33950.320993580484;34297;22062.779372206074;24939.875300623382;25161.748382516675;25237.369065773502;25689.614655779806 09:52:24 INFO - PROCESS | 1939 | |2;jquery.html;316.50151012155857;351.62903137190284;369.9741018128732;372.22391314110087;400.6654443539644;14958;15218.23908804561;15880.285387157577;18508.2596696132;20636.38090857273;19726.70409943852;19745.815251084943;20229.59540809183;20524.179032838707;20540.69188962163;5575.8606034849145;5979.431953964388;5981;5982.042873140298;5991.191189189469;5011.924821127686;5063.493650634926;5892.410758924116;5969.820905372824;5977.940220597782;5660.29246344207;5908.911366329508;5910.852228694274;5910.970445147768;5913.349531551526;5245.344331958505;5551.306086739117;5661.60368774186;5829.679367634779;5837.678927658977;4932.556069953722;5012.097822391968;5050.545450909399;5055.519725626096;5059.6458247922665;24714.876425617756;25026.49947001068;25053.37366565832;25360.619590706156;25373;2195.9231426899983;2212.104097840377;2244.102359056374;2335.988320058389;2353.0940587873793;14141.29293535319;15122.54632361031;15211.315490802941;15357.078575285406;15382.384704611914;1773.939953580077;1790.5523619095227;1811.936582219616;1817.954551136232;1933.4296382567177;117675;120000.39999800033;120278;121107.394463028;123875;10076.949615251877;10156.695299141038;10578.57685692579;10585.41780202081;10950.178736594788;12880.484780608858;12908;12924.935375323063;12926;12936.547220847226;7944.880826787603;8208.876866847002;8215.794605134919;8374.623141958626;8420.663173473115;8228.670853165806;8260.215279548433;8270.545120018456;8473.449225800303;8495.108013658477;5700.7719691212715;5723.914141287884;6143.354947730424;6288.717007734663;6307.779227727007;1757.4112672254682;1777.3601503458744;1783.4649605118414;1791.4536066499843;1818.1909050472677;905.5970093308546;906.5648488725449;913.2009491694768;930.0327659234456;999.1856636840952;20348.389548313575;20668;20728.792712072987;20890.895545522177;20945.58108837815;951.4006176109007;956.1396976692344;966.9468179250209;1010.2877471382658;1022.5296363672794;10703.464826758787;11137.554497820158;11152.888471115184;11338.60314888975;11369.658910232707;589202;592738.0363098157;602416;607125;607832;90154;95605;101508.98491015143;119678;127078.72921270669;816.5345752920778;937.2221056523069;1008.193445243802;1008.6923488336128;1010.3887148275335;17975.37086202029;18744.53138671544;19192.232310707415;19204.231830726614;19282.517937051685;51747.48252517577;52085.7395713019;52214.47785522248;52585.42243732694;53684.92630147297;54076.648083798216;63737.68131159314;66966.66516667386;66982;69995.65002174956;6873.793786186422;7199.2440793715905;7220.602866842164;7443.962780186064;7786.143524212219;11898.22661526998;12108.455119519467;12514.687132821753;13050.54323098725;13283.335833208494;10605.840912386475;11062.778744425228;11140.16448766362;11245.71885702864;11394.772104558027;8714.956425217833;10627.840582391116;10772.299800512941;11169.106471482099;11358.204925655125;10772.030517253172;10876.23866329381;10919.672409827717;11315.151363647594;11407;7107.892107892108;7227.193201699575;7298.489105762758;7347.302006309392;7474.7757567273065;9201.263898887939;10768.569257229936;11020;11040.447977600927;11078.833817492905 09:52:24 INFO - PROCESS | 1939 | |3;mootools.html;1475.638468575199;1525.2145145250195;1753.7281721333197;1891.8486521078314;1938.4572319750475;8603.827923441535;9157.542122893861;9157.679481218158;9158;9173.312001599874;8068.636911338989;8314.41799074065;8322.084570697234;8443.831123377544;8913.153250441213;2155.805977462024;2185.530111026129;2298.161171172527;2375.3824005758543;2386.4391867911027;2374.0859768988976;2377.346229786805;2382.4282172278704;2387.546366190418;2388.5461762265113;2354.0819080558595;2364.869932153731;2397.412633904687;2401.3756423329974;2401.7238017627933;2357;2361.1499860050367;2378.2389635316704;2379.452725873042;2380.0955636858057;2339.9649005264932;2355.222776483756;2362.8227882908677;2366.0535785685865;2370.253370188402;8800.295976321879;9000.684976025874;9022.86465703015;9030.50332231727;9035.096490350978;5234.502722241381;5413.26920865682;5416.458354164592;5417.5395091416885;5430.456954304577;3545.5213546171194;3699.7040236780995;3767.6232376762377;3780.4140358244517;3790.8294126764363;1035.7373828130783;1085.4572713643179;1107.7009207514006;1110.3227031510771;1112.9666110016713;11962.880371196263;12034.81947770784;12054.939725301405;12064.155509114365;12066.939665301705;3821.38857782759;4405.911881762411;4759.785809638574;4763.476017638057;4768.856934291907;9834.754131146636;10049.497525123714;10107.3430227035;10156.796864062677;10157.898421015843;5392.975334686475;5395.406505284415;5404.54061404785;5405.378386484039;5416.350037995466;4729.574338309569;4861.854144375674;4942.233953737176;4958.826441074617;4959.90080198394;3662.1577037281572;3764.284785890672;3771.9057023574082;3833.3674943634546;3899.337112690849;1075.7687097274124;1091.9672409827717;1272.7709012377675;1274.2290913996899;1289.1491615533703;848.5290663681716;860.6858496648678;888.5113187746714;914.4193437167313;952.3381250031161;5721.799737009184;5812.88374232513;6039.667818270037;6054.909176362358;6150.753969841246;912.6668765900398;947.7393716727817;951.1724799424406;957.9425234485954;1008.9243306752023;3896.668783153407;4013.91972160561;4026.617471340218;4088.7546747195265;4089.345704687236;10459.372437653765;10726.141908647289;10745.40900250478;10861.2940158891;10887.129029677766;10814.35113893169;10815.83776243357;10828.187885908588;10829.241953063367;10845.945770271255;7761;8127.187281271826;8400.117987611335;8408.117147699526;8411.579421028924;5961.2846458425265;6086.591508755111;6091.604045737013;6133.26400831903;6196.3803619639475;9740.464274464972;9927.602895884083;10159.644412445528;10271.486425678537;10295.227857910537;9871.555779989774;10106.747331316776;10107.7473063174;10381.221408394249;10489.632862850069;7953.363730901629;8155.79610509742;8411.242988130853;8419.95790021046;8430.83138337242;7572.20491848348;7839.137694853675;7848.7645370638975;8293.33653307746;8424.283935865275;7465.701371945279;7504.512206706547;7507.812304692208;7604;7618.466707330434;7411.2588741125455;7442;7501.362384197404;7547.245275472628;7559.962200189184;6972.302769722987;6991.545549539263;6991.580505169706;7042.718291268292;7087;5016.648834581544;5031.6226283029655;5037.622178336566;5045.167547354646;5166.6125040621355;4868.61051115917;4960.652754307308;5130.256112863689;5171.405288391883;5260.736963151904 09:52:24 INFO - PROCESS | 1939 | |4;prototype.html;247.29274275571862;292.38307171867353;305.81651009394363;309.2068843416636;316.4541166487807;4883.19427294496;5110.795568177277;5112.8977420451565;5123.615728820339;5154.819581314655;3874.8643797467093;4573.817047318112;4953.835848575582;4975.577075948549;5011.970152088401;3866.3427217372973;3891.727579069466;3897;3915.843366265353;3917.784521851297;3855.4024126260333;3935.4096885467125;3950.4666869972616;3952.5454572724216;3957.832439430375;3009.759219262454;3069.7083777041257;3502.7197824174004;3715.758475699071;3829.5404551453867;3859.2281543691233;3877.592852750449;3898.5906479819496;3919.2553414851086;3943;2939.7207265309976;3022.909312720622;3102.674219206996;3361.932761344784;3431.7769344992494;4597.954020459786;4919.680220785674;4951.282064100686;4965;4978.103941290602;4078.4697989261504;4357.912841743179;4378.598848368523;4399.580230873039;4446.266366049598;4464.955350446487;4576.839810606646;4817.686850354716;5193.065248255312;5352.4915133062295;3406.489026646023;3433.1760377509468;3681.932239650498;3691.6492933171576;3694.8152592370275;4757.524247575249;4874.000829829912;5062.291279220912;5104.719240441774;5614.550835933115;3282.622498412665;3559.875404360887;3610.548681414823;3703.518542589446;3724.3110024645525;3337.4493208620793;3687.244114956481;3779.3764028934916;3789.5642001169667;3807.238552289498;4184.686148538872;4368.301071828492;4375.759333236639;4384.320430333303;4428.822847086145;4937.5556199942175;5261.500157485033;5291.761870715827;5308.309919710413;5329.974609648309;1215.5198696515004;1281.3144967442374;1284.3642397013352;1287.896968242557;1288.2013151845915;747.3796748698567;771.733751855609;782.3897360059163;795.0538858758059;798.1101072304455;3550.6449355064287;3758.4174452959833;4142.565030671736;4162.876023473646;4236.9788151059665;4455;4473.552644735565;4487.52217031803;4519.480259770168;4549.613282870927;3340.6492318306714;3588.6052534221217;4061.5329237137516;4093.467849179647;4098.442591815091;2088.488320361491;2308.230123851385;2377.669883514166;2382.9404264893515;2865.555838844982;4986.282476050561;5656.236408084938;5670.476637896179;5670.5747068969995;5682.431756824284;4383.517813040563;5581.441855814386;5607.775529070801;5617.354004289477;5618.91571626426;5368.8389348319615;5570;5574.442555744393;5587.664740115606;5601.383847776659;4582.977085114553;4659.138059459011;5360.383555891122;5365.946340536545;5436.130219165073;4721.386219791405;5338.626296159232;5375.715320988643;5378.5966052547;5407.945920540744;4950.816560006789;5039.622028347815;5254.763535640982;5469.890602188014;5575.386707462257;3025.5007923693224;3529.8764543240864;3670.6879915207505;3679.356112680217;3687.916327275081;4770.332153498443;4781.995780886053;4959.429665588504;5399.271098401666;5485.9725701371235;4675.976620116878;4707.246840505502;4855.562999329936;5106.974465127651;5240;5198.752299448181;5218.478152184751;5225.615211968755;5228.111221092499;5235.591627851231;4277.401163837003;4311.1377724454605;5114.565261952627;5133.79464821403;5180.611454140879;4437.8890527735775;4980.850574482772;5112.412072611697;5249.685018898878;5256.816011439734;4541.636669066533;5109.9233511498105;5131.255967884561;5148.730556096831;5158.406783219978 09:52:24 INFO - PROCESS | 1939 | |5;yui.html;625.590238393852;702.7189124350259;721.4480922094599;759.1952530317867;783.5612057247941;14510.347034383438;14542.636434089127;14543.200123993176;14553.41786328547;14873.553793386202;13362.265075420848;13740.381682824273;13782;13782.931085344584;13823.585292441217;667.0594461808851;694.6249025526209;834.3825569078898;847.1613103027988;860.5052095045374;862.3316929379719;869.4305230074311;873.1007062725403;874.5190145420025;875.7504111328273;920.2729843423688;921.0789210789211;921.8018126102886;922.7093465558361;923.487464457226;715.2418436457319;737.9557226566424;913.4747520175926;915.6428992692855;915.7161280003187;550.6806052489546;551.0604419464803;552.1248820619323;670.7115940145735;690.3683129936103;14759.77860332096;14878.70242595153;14883.851161488356;14888.404463821435;14946.70106597862;13573.1856088635;13728.862711372858;13830.377633006437;13921.58235252944;14229.359678814375;12301.56944506947;12515.812262815974;12606.621801345975;12617.242965422103;13140.802887956688;4508.053308805155;4606.976965115186;4624.560666736655;4632.745199014053;4718.622510199176;90104;105339.47330263376;108909;114799.85200147975;114852;10711.517981690688;10928.726781830359;11216.66350009501;11285.887141128647;11373.658790236306;21310.254141104986;21437.785622143892;21452;21460.712357258613;21461.78538214598;7769.417293702995;7863;7901.762947111596;8055.4763940344865;8127;4204.66362690984;4325.848595299212;4344.370066340363;4354.325079612602;4489.304157855472;3277.967220327766;3373.308471763283;3374.5106959490736;3380.2394461246513;3380.864765409405;645.6481217736344;652.46171908175;661.2825084783065;668.8963210702349;674.6458109492555;517.531633871347;533.9155460725405;543.2476020711343;584.8917950179231;586.5923183387505;7239.674214660353;7876.921230787733;8727.781805454788;8845.867311990325;8955.507447090473;520.5133200457584;557.2783245696833;615.9384061593894;626.1265534579236;626.7336382037615;3775.3959366501226;4288.2495563276925;4397.186520493655;4404.757738324423;4530.29780384041;84045.57977210075;84171.15828841634;88758.66861997075;156581.43418565896;160882.1955890213;100392;124325.37837310755;129766;137579;139766;53897;110848.44575777231;111478;115819.8418015809;119052.40473797575;8465;8492.575371231538;8620.224179823846;8709.738707838775;8723.345749068718;62404.68797656164;62480.375196247456;63741;63777;64982.35017649763;72069.63965180141;91474.3641017434;92097.53951230469;93277;96401.093819519;11244.55021799119;11306.321620702454;11480.368579727861;11698.824517632413;11730;10713.517891695048;12145.672237465702;12262.570810021607;12419.751604967669;12519.496100780063;11478;11685;11947.701307467383;11958.64124076279;12044.819327710267;11216.775664486502;11934.462949167135;13534;13868.514601989285;14185.219812910389;13581;13759.380827862971;13836.654083647989;13921.512747053805;14257.083895547496;11070.778584428428;11320.547178112784;11475.254108482923;11511.07911367072;11727.237729547553;10353.378797271887;11359.09127269833;11491.367974761468;11659;11675.241109327866 09:52:24 INFO - PROCESS | 1939 | __end_tp_report 09:52:24 INFO - PROCESS | 1939 | __start_cc_report 09:52:24 INFO - PROCESS | 1939 | _x_x_mozilla_cycle_collect,1512 09:52:24 INFO - PROCESS | 1939 | __end_cc_report 09:52:24 INFO - PROCESS | 1939 | __startTimestamp1475599944274__endTimestamp 09:52:24 INFO - PROCESS | 1939 | 09:52:24 INFO - PROCESS | 1939 | ------- Summary: start ------- 09:52:24 INFO - PROCESS | 1939 | Number of tests: 6 09:52:24 INFO - PROCESS | 1939 | 09:52:24 INFO - PROCESS | 1939 | [#0] dojo.html Cycles:165 Average:5618.68 Median:5730.68 stddev:655.43 (11.4%) stddev-sans-first:631.05 09:52:24 INFO - PROCESS | 1939 | Values: 3271.6 3282.6 3297.1 3311.3 3364.8 5493.9 5547.8 5608.9 5626.5 5640.0 5548.9 5585.2 5600.0 5607.2 5619.6 5077.0 5111.3 5118.1 5123.4 5200.9 5123.5 5130.1 5183.5 5208.6 5214.7 4379.8 5175.5 5204.7 5219.6 5244.5 5075.4 5185.3 5194.4 5202.1 5269.8 4295.0 4390.0 4808.0 5105.7 5156.4 5527.6 5530.3 5577.7 5582.6 5588.4 6087.1 6102.5 6106.4 6111.0 6125.8 6058.6 6064.0 6102.6 6113.6 6189.1 5653.2 5690.0 5691.4 5692.9 5717.5 6309.6 6316.8 6319.5 6319.8 6329.5 5842.6 5905.8 5919.5 5984.3 5988.0 6128.8 6130.9 6156.7 6189.0 6191.8 6074.7 6095.0 6099.5 6111.4 6115.9 5949.2 6057.2 6131.3 6145.3 6170.1 4789.5 4814.4 4822.1 4824.5 4827.6 4317.4 4322.9 4349.6 4361.2 4445.4 5690.7 5717.0 5720.0 5727.9 5733.9 6179.6 6205.3 6207.4 6216.9 6232.8 5670.8 5683.4 5683.9 5692.5 5695.7 4958.7 5168.9 5192.6 5251.9 5298.7 6265.7 6306.4 6341.5 6345.5 6350.9 6176.4 6178.0 6184.3 6190.2 6194.3 6156.4 6168.9 6239.9 6311.7 6325.3 6039.2 6069.5 6080.6 6111.5 6129.1 6130.0 6164.2 6184.4 6184.8 6201.6 5472.9 5524.7 5552.3 5902.6 5970.0 5516.6 5873.5 5875.7 5924.7 5996.7 4999.2 5585.1 5793.4 5807.7 5835.8 5009.0 5939.4 5943.1 5953.4 5967.9 5624.5 5730.7 5762.0 5763.2 5826.5 09:52:24 INFO - PROCESS | 1939 | 09:52:24 INFO - PROCESS | 1939 | [#1] ext.html Cycles:180 Average:66523.29 Median:39094.32 stddev:148705.58 (380.4%) stddev-sans-first:149040.01 09:52:24 INFO - PROCESS | 1939 | Values: 460.3 481.6 529.2 542.2 547.2 30548.8 31614.8 33824.5 39829.6 43631.0 42333.8 42493.0 42842.4 42852.7 42901.8 9710.6 9893.8 9894.5 9909.7 9921.0 9687.3 9797.3 9799.1 9799.2 9800.9 9801.4 9810.5 9829.2 9847.6 9864.2 9729.3 9793.5 9808.6 9810.9 9812.2 9715.4 9740.6 9741.7 9753.1 9776.3 40730.4 41030.8 41136.8 41158.6 41179.0 3295.7 3314.3 3347.6 3380.9 3381.4 30666.7 31076.8 31496.7 32205.2 32214.4 3167.2 3187.4 3224.2 3328.8 3333.2 298499.0 302926.5 303227.0 303367.0 303386.0 59185.5 60211.4 63759.0 64710.0 64787.7 32947.0 33223.0 33321.5 68026.3 69415.0 16013.4 16357.4 16418.3 16426.3 16454.0 12367.9 12462.5 12478.7 12482.2 12484.5 16713.9 20370.6 20568.0 20620.0 20686.0 8643.4 8727.6 8737.6 8750.6 8839.6 855.4 950.1 1029.0 1035.7 1077.9 23029.9 29099.0 29694.3 30411.5 30453.7 1035.8 1037.1 1057.7 1068.8 1105.6 14909.0 15459.0 15530.1 15717.8 15892.4 686413.0 689812.0 690558.0 690666.0 691699.0 57654.1 58081.7 58127.4 58192.0 58441.0 1314.5 1362.8 1379.4 1380.9 1381.6 23995.0 24668.3 29760.1 29930.9 30130.5 49704.0 50052.5 50198.0 50225.0 50351.5 592403.0 593876.0 594373.0 594698.0 595109.0 27035.3 27122.5 27394.3 27456.5 27541.0 46979.3 47319.1 48388.0 48443.5 48750.3 39305.4 39344.0 39501.2 39503.6 40852.6 38475.6 38876.0 40201.4 40264.8 40651.6 37478.0 37584.6 38588.2 38741.8 38883.2 32540.0 32595.3 32718.0 33950.3 34297.0 22062.8 24939.9 25161.7 25237.4 25689.6 09:52:24 INFO - PROCESS | 1939 | 09:52:24 INFO - PROCESS | 1939 | [#2] jquery.html Cycles:180 Average:34047.59 Median:13533.99 stddev:99589.20 (735.8%) stddev-sans-first:99836.37 09:52:24 INFO - PROCESS | 1939 | Values: 316.5 351.6 370.0 372.2 400.7 14958.0 15218.2 15880.3 18508.3 20636.4 19726.7 19745.8 20229.6 20524.2 20540.7 5575.9 5979.4 5981.0 5982.0 5991.2 5011.9 5063.5 5892.4 5969.8 5977.9 5660.3 5908.9 5910.9 5911.0 5913.3 5245.3 5551.3 5661.6 5829.7 5837.7 4932.6 5012.1 5050.5 5055.5 5059.6 24714.9 25026.5 25053.4 25360.6 25373.0 2195.9 2212.1 2244.1 2336.0 2353.1 14141.3 15122.5 15211.3 15357.1 15382.4 1773.9 1790.6 1811.9 1818.0 1933.4 117675.0 120000.4 120278.0 121107.4 123875.0 10076.9 10156.7 10578.6 10585.4 10950.2 12880.5 12908.0 12924.9 12926.0 12936.5 7944.9 8208.9 8215.8 8374.6 8420.7 8228.7 8260.2 8270.5 8473.4 8495.1 5700.8 5723.9 6143.4 6288.7 6307.8 1757.4 1777.4 1783.5 1791.5 1818.2 905.6 906.6 913.2 930.0 999.2 20348.4 20668.0 20728.8 20890.9 20945.6 951.4 956.1 966.9 1010.3 1022.5 10703.5 11137.6 11152.9 11338.6 11369.7 589202.0 592738.0 602416.0 607125.0 607832.0 90154.0 95605.0 101509.0 119678.0 127078.7 816.5 937.2 1008.2 1008.7 1010.4 17975.4 18744.5 19192.2 19204.2 19282.5 51747.5 52085.7 52214.5 52585.4 53684.9 54076.6 63737.7 66966.7 66982.0 69995.7 6873.8 7199.2 7220.6 7444.0 7786.1 11898.2 12108.5 12514.7 13050.5 13283.3 10605.8 11062.8 11140.2 11245.7 11394.8 8715.0 10627.8 10772.3 11169.1 11358.2 10772.0 10876.2 10919.7 11315.2 11407.0 7107.9 7227.2 7298.5 7347.3 7474.8 9201.3 10768.6 11020.0 11040.4 11078.8 09:52:24 INFO - PROCESS | 1939 | 09:52:24 INFO - PROCESS | 1939 | [#3] mootools.html Cycles:180 Average:5789.96 Median:4950.53 stddev:3254.40 (65.7%) stddev-sans-first:3247.38 09:52:24 INFO - PROCESS | 1939 | Values: 1475.6 1525.2 1753.7 1891.8 1938.5 8603.8 9157.5 9157.7 9158.0 9173.3 8068.6 8314.4 8322.1 8443.8 8913.2 2155.8 2185.5 2298.2 2375.4 2386.4 2374.1 2377.3 2382.4 2387.5 2388.5 2354.1 2364.9 2397.4 2401.4 2401.7 2357.0 2361.1 2378.2 2379.5 2380.1 2340.0 2355.2 2362.8 2366.1 2370.3 8800.3 9000.7 9022.9 9030.5 9035.1 5234.5 5413.3 5416.5 5417.5 5430.5 3545.5 3699.7 3767.6 3780.4 3790.8 1035.7 1085.5 1107.7 1110.3 1113.0 11962.9 12034.8 12054.9 12064.2 12066.9 3821.4 4405.9 4759.8 4763.5 4768.9 9834.8 10049.5 10107.3 10156.8 10157.9 5393.0 5395.4 5404.5 5405.4 5416.4 4729.6 4861.9 4942.2 4958.8 4959.9 3662.2 3764.3 3771.9 3833.4 3899.3 1075.8 1092.0 1272.8 1274.2 1289.1 848.5 860.7 888.5 914.4 952.3 5721.8 5812.9 6039.7 6054.9 6150.8 912.7 947.7 951.2 957.9 1008.9 3896.7 4013.9 4026.6 4088.8 4089.3 10459.4 10726.1 10745.4 10861.3 10887.1 10814.4 10815.8 10828.2 10829.2 10845.9 7761.0 8127.2 8400.1 8408.1 8411.6 5961.3 6086.6 6091.6 6133.3 6196.4 9740.5 9927.6 10159.6 10271.5 10295.2 9871.6 10106.7 10107.7 10381.2 10489.6 7953.4 8155.8 8411.2 8420.0 8430.8 7572.2 7839.1 7848.8 8293.3 8424.3 7465.7 7504.5 7507.8 7604.0 7618.5 7411.3 7442.0 7501.4 7547.2 7560.0 6972.3 6991.5 6991.6 7042.7 7087.0 5016.6 5031.6 5037.6 5045.2 5166.6 4868.6 4960.7 5130.3 5171.4 5260.7 09:52:24 INFO - PROCESS | 1939 | 09:52:24 INFO - PROCESS | 1939 | [#4] prototype.html Cycles:180 Average:4175.22 Median:4545.62 stddev:1296.74 (28.5%) stddev-sans-first:1266.42 09:52:24 INFO - PROCESS | 1939 | Values: 247.3 292.4 305.8 309.2 316.5 4883.2 5110.8 5112.9 5123.6 5154.8 3874.9 4573.8 4953.8 4975.6 5012.0 3866.3 3891.7 3897.0 3915.8 3917.8 3855.4 3935.4 3950.5 3952.5 3957.8 3009.8 3069.7 3502.7 3715.8 3829.5 3859.2 3877.6 3898.6 3919.3 3943.0 2939.7 3022.9 3102.7 3361.9 3431.8 4598.0 4919.7 4951.3 4965.0 4978.1 4078.5 4357.9 4378.6 4399.6 4446.3 4465.0 4576.8 4817.7 5193.1 5352.5 3406.5 3433.2 3681.9 3691.6 3694.8 4757.5 4874.0 5062.3 5104.7 5614.6 3282.6 3559.9 3610.5 3703.5 3724.3 3337.4 3687.2 3779.4 3789.6 3807.2 4184.7 4368.3 4375.8 4384.3 4428.8 4937.6 5261.5 5291.8 5308.3 5330.0 1215.5 1281.3 1284.4 1287.9 1288.2 747.4 771.7 782.4 795.1 798.1 3550.6 3758.4 4142.6 4162.9 4237.0 4455.0 4473.6 4487.5 4519.5 4549.6 3340.6 3588.6 4061.5 4093.5 4098.4 2088.5 2308.2 2377.7 2382.9 2865.6 4986.3 5656.2 5670.5 5670.6 5682.4 4383.5 5581.4 5607.8 5617.4 5618.9 5368.8 5570.0 5574.4 5587.7 5601.4 4583.0 4659.1 5360.4 5365.9 5436.1 4721.4 5338.6 5375.7 5378.6 5407.9 4950.8 5039.6 5254.8 5469.9 5575.4 3025.5 3529.9 3670.7 3679.4 3687.9 4770.3 4782.0 4959.4 5399.3 5486.0 4676.0 4707.2 4855.6 5107.0 5240.0 5198.8 5218.5 5225.6 5228.1 5235.6 4277.4 4311.1 5114.6 5133.8 5180.6 4437.9 4980.9 5112.4 5249.7 5256.8 4541.6 5109.9 5131.3 5148.7 5158.4 09:52:24 INFO - PROCESS | 1939 | 09:52:24 INFO - PROCESS | 1939 | [#5] yui.html Cycles:180 Average:23274.87 Median:3990.03 stddev:36842.62 (923.4%) stddev-sans-first:36906.73 09:52:24 INFO - PROCESS | 1939 | Values: 625.6 702.7 721.4 759.2 783.6 14510.3 14542.6 14543.2 14553.4 14873.6 13362.3 13740.4 13782.0 13782.9 13823.6 667.1 694.6 834.4 847.2 860.5 862.3 869.4 873.1 874.5 875.8 920.3 921.1 921.8 922.7 923.5 715.2 738.0 913.5 915.6 915.7 550.7 551.1 552.1 670.7 690.4 14759.8 14878.7 14883.9 14888.4 14946.7 13573.2 13728.9 13830.4 13921.6 14229.4 12301.6 12515.8 12606.6 12617.2 13140.8 4508.1 4607.0 4624.6 4632.7 4718.6 90104.0 105339.5 108909.0 114799.9 114852.0 10711.5 10928.7 11216.7 11285.9 11373.7 21310.3 21437.8 21452.0 21460.7 21461.8 7769.4 7863.0 7901.8 8055.5 8127.0 4204.7 4325.8 4344.4 4354.3 4489.3 3278.0 3373.3 3374.5 3380.2 3380.9 645.6 652.5 661.3 668.9 674.6 517.5 533.9 543.2 584.9 586.6 7239.7 7876.9 8727.8 8845.9 8955.5 520.5 557.3 615.9 626.1 626.7 3775.4 4288.2 4397.2 4404.8 4530.3 84045.6 84171.2 88758.7 156581.4 160882.2 100392.0 124325.4 129766.0 137579.0 139766.0 53897.0 110848.4 111478.0 115819.8 119052.4 8465.0 8492.6 8620.2 8709.7 8723.3 62404.7 62480.4 63741.0 63777.0 64982.4 72069.6 91474.4 92097.5 93277.0 96401.1 11244.6 11306.3 11480.4 11698.8 11730.0 10713.5 12145.7 12262.6 12419.8 12519.5 11478.0 11685.0 11947.7 11958.6 12044.8 11216.8 11934.5 13534.0 13868.5 14185.2 13581.0 13759.4 13836.7 13921.5 14257.1 11070.8 11320.5 11475.3 11511.1 11727.2 10353.4 11359.1 11491.4 11659.0 11675.2 09:52:24 INFO - PROCESS | 1939 | -------- Summary: end -------- 09:52:24 INFO - PROCESS | 1939 | 09:52:25 INFO - TEST-INFO | 1939: exit 0 09:52:25 INFO - TEST-OK | dromaeo_css | took 1118943ms 09:52:25 INFO - TEST-START | kraken 09:52:25 INFO - operating with platform_type : mac_ 09:52:25 INFO - Initialising browser for kraken test... 09:52:25 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpUWp5eF/profile http://localhost:50886/getInfo.html) 09:52:27 INFO - PROCESS | 1943 | __metrics Screen width/height:1600/1200 09:52:27 INFO - PROCESS | 1943 | colorDepth:24 09:52:27 INFO - PROCESS | 1943 | Browser inner width/height: 1024/689 09:52:27 INFO - PROCESS | 1943 | __metrics 09:52:27 INFO - PROCESS | 1943 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:52:27 INFO - PROCESS | 1943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:28 INFO - TEST-INFO | 1943: exit 0 09:52:28 INFO - Browser initialized. 09:52:28 INFO - Running cycle 1/1 for kraken test... 09:52:28 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpUWp5eF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:40 INFO - PROCESS | 1944 | RSS: Main: 236302336 09:52:40 INFO - PROCESS | 1944 | 09:52:42 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50886/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:43 INFO - PROCESS | 1944 | RSS: Main: 294907904 09:52:43 INFO - PROCESS | 1944 | 09:52:46 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50886/tests/kraken/driver.html?testName=audio-dft) 09:52:47 INFO - PROCESS | 1944 | RSS: Main: 294998016 09:52:47 INFO - PROCESS | 1944 | 09:52:50 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50886/tests/kraken/driver.html?testName=audio-fft) 09:52:51 INFO - PROCESS | 1944 | RSS: Main: 384516096 09:52:51 INFO - PROCESS | 1944 | 09:52:53 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50886/tests/kraken/driver.html?testName=audio-oscillator) 09:52:53 INFO - PROCESS | 1944 | RSS: Main: 286605312 09:52:53 INFO - PROCESS | 1944 | 09:52:55 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50886/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:56 INFO - PROCESS | 1944 | RSS: Main: 291151872 09:52:56 INFO - PROCESS | 1944 | 09:52:59 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50886/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:59 INFO - PROCESS | 1944 | RSS: Main: 327958528 09:52:59 INFO - PROCESS | 1944 | 09:53:02 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50886/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:03 INFO - PROCESS | 1944 | RSS: Main: 330207232 09:53:03 INFO - PROCESS | 1944 | 09:53:06 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50886/tests/kraken/driver.html?testName=json-parse-financial) 09:53:06 INFO - PROCESS | 1944 | RSS: Main: 328638464 09:53:06 INFO - PROCESS | 1944 | 09:53:08 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50886/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:08 INFO - PROCESS | 1944 | RSS: Main: 304140288 09:53:08 INFO - PROCESS | 1944 | 09:53:10 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50886/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:11 INFO - PROCESS | 1944 | RSS: Main: 305590272 09:53:11 INFO - PROCESS | 1944 | 09:53:13 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50886/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:14 INFO - PROCESS | 1944 | RSS: Main: 315285504 09:53:14 INFO - PROCESS | 1944 | 09:53:17 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:17 INFO - PROCESS | 1944 | RSS: Main: 321392640 09:53:17 INFO - PROCESS | 1944 | 09:53:20 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:21 INFO - PROCESS | 1944 | RSS: Main: 321667072 09:53:21 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:50886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50886/tests/kraken/driver.html?testName=ai-astar) 09:53:23 INFO - PROCESS | 1944 | RSS: Main: 365457408 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | __start_tp_report 09:53:23 INFO - PROCESS | 1944 | _x_x_mozilla_page_load 09:53:23 INFO - PROCESS | 1944 | _x_x_mozilla_page_load_details 09:53:23 INFO - PROCESS | 1944 | |i|pagename|runs| 09:53:23 INFO - PROCESS | 1944 | |0;ai-astar;112;113;114;113;113;114;113;112;112;112 09:53:23 INFO - PROCESS | 1944 | |1;audio-beat-detection;149;114;114;149;113;113;114;114;145;139 09:53:23 INFO - PROCESS | 1944 | |2;audio-dft;182;184;183;187;185;182;183;184;180;183 09:53:23 INFO - PROCESS | 1944 | |3;audio-fft;80;57;59;88;62;60;60;92;82;57 09:53:23 INFO - PROCESS | 1944 | |4;audio-oscillator;88;69;91;70;89;101;129;67;70;90 09:53:23 INFO - PROCESS | 1944 | |5;imaging-gaussian-blur;87;85;87;85;88;84;87;84;87;84 09:53:23 INFO - PROCESS | 1944 | |6;imaging-darkroom;95;96;95;95;95;96;95;95;95;95 09:53:23 INFO - PROCESS | 1944 | |7;imaging-desaturate;87;86;84;85;88;85;84;83;85;85 09:53:23 INFO - PROCESS | 1944 | |8;json-parse-financial;56;53;53;53;54;54;55;53;54;54 09:53:23 INFO - PROCESS | 1944 | |9;json-stringify-tinderbox;70;67;67;73;70;68;69;67;67;74 09:53:23 INFO - PROCESS | 1944 | |10;stanford-crypto-aes;88;89;89;86;88;85;89;91;88;92 09:53:23 INFO - PROCESS | 1944 | |11;stanford-crypto-ccm;147;147;143;145;144;145;147;146;176;143 09:53:23 INFO - PROCESS | 1944 | |12;stanford-crypto-pbkdf2;171;172;173;171;170;168;176;236;197;169 09:53:23 INFO - PROCESS | 1944 | |13;stanford-crypto-sha256-iterative;69;74;83;88;88;88;68;69;69;70 09:53:23 INFO - PROCESS | 1944 | __end_tp_report 09:53:23 INFO - PROCESS | 1944 | __start_cc_report 09:53:23 INFO - PROCESS | 1944 | _x_x_mozilla_cycle_collect,1981 09:53:23 INFO - PROCESS | 1944 | __end_cc_report 09:53:23 INFO - PROCESS | 1944 | __startTimestamp1475600003678__endTimestamp 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | ------- Summary: start ------- 09:53:23 INFO - PROCESS | 1944 | Number of tests: 14 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 09:53:23 INFO - PROCESS | 1944 | Values: 112.0 113.0 114.0 113.0 113.0 114.0 113.0 112.0 112.0 112.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:126.50 stddev:16.67 (13.2%) stddev-sans-first:15.54 09:53:23 INFO - PROCESS | 1944 | Values: 149.0 114.0 114.0 149.0 113.0 113.0 114.0 114.0 145.0 139.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.89 (1.0%) stddev-sans-first:1.94 09:53:23 INFO - PROCESS | 1944 | Values: 182.0 184.0 183.0 187.0 185.0 182.0 183.0 184.0 180.0 183.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#3] audio-fft Cycles:10 Average:69.70 Median:71.00 stddev:14.04 (19.8%) stddev-sans-first:14.39 09:53:23 INFO - PROCESS | 1944 | Values: 80.0 57.0 59.0 88.0 62.0 60.0 60.0 92.0 82.0 57.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:79.00 stddev:19.11 (24.2%) stddev-sans-first:20.27 09:53:23 INFO - PROCESS | 1944 | Values: 88.0 69.0 91.0 70.0 89.0 101.0 129.0 67.0 70.0 90.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.55 (1.8%) stddev-sans-first:1.58 09:53:23 INFO - PROCESS | 1944 | Values: 87.0 85.0 87.0 85.0 88.0 84.0 87.0 84.0 87.0 84.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:53:23 INFO - PROCESS | 1944 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.48 (1.7%) stddev-sans-first:1.41 09:53:23 INFO - PROCESS | 1944 | Values: 87.0 86.0 84.0 85.0 88.0 85.0 84.0 83.0 85.0 85.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.99 (1.8%) stddev-sans-first:0.71 09:53:23 INFO - PROCESS | 1944 | Values: 56.0 53.0 53.0 53.0 54.0 54.0 55.0 53.0 54.0 54.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:2.57 (3.7%) stddev-sans-first:2.71 09:53:23 INFO - PROCESS | 1944 | Values: 70.0 67.0 67.0 73.0 70.0 68.0 69.0 67.0 67.0 74.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.00 stddev:2.07 (2.3%) stddev-sans-first:2.19 09:53:23 INFO - PROCESS | 1944 | Values: 88.0 89.0 89.0 86.0 88.0 85.0 89.0 91.0 88.0 92.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:146.50 stddev:9.86 (6.7%) stddev-sans-first:10.44 09:53:23 INFO - PROCESS | 1944 | Values: 147.0 147.0 143.0 145.0 144.0 145.0 147.0 146.0 176.0 143.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:172.50 stddev:21.29 (12.3%) stddev-sans-first:22.32 09:53:23 INFO - PROCESS | 1944 | Values: 171.0 172.0 173.0 171.0 170.0 168.0 176.0 236.0 197.0 169.0 09:53:23 INFO - PROCESS | 1944 | 09:53:23 INFO - PROCESS | 1944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:78.50 stddev:9.00 (11.5%) stddev-sans-first:9.11 09:53:23 INFO - PROCESS | 1944 | Values: 69.0 74.0 83.0 88.0 88.0 88.0 68.0 69.0 69.0 70.0 09:53:23 INFO - PROCESS | 1944 | -------- Summary: end -------- 09:53:23 INFO - PROCESS | 1944 | 09:53:24 INFO - TEST-INFO | 1944: exit 0 09:53:24 INFO - TEST-OK | kraken | took 59483ms 09:53:24 INFO - SUITE-END | took 1178s 09:53:24 INFO - Completed test suite (00:19:38) 09:53:24 INFO - javascript benchmark 09:53:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3271.6401195868457, 3282.6224984126825, 3297.0603378037263, 3311.33773245351, 3364.764466487347, 5493.945060549393, 5547.805826796058, 5608.887822243558, 5626.54987600992, 5640.012997725397, 5548.944510554903, 5585.162225666152, 5600.019996500606, 5607.186957891104, 5619.634723742954, 5076.959223359212, 5111.284420181159, 5118.07874582575, 5123.410807757118, 5200.895982080356, 5123.513266239701, 5130.07658621448, 5183.53348198662, 5208.583313334924, 5214.687118772867, 4379.795556222032, 5175.508326708976, 5204.739763011853, 5219.608529360313, 5244.501772331622, 5075.390953085616, 5185.299984502081, 5194.428612852583, 5202.0896343140175, 5269.789208431658, 4295.0, 4389.978050109761, 4808.0, 5105.668131571436, 5156.432792392871, 5527.55779537636, 5530.308711411074, 5577.749001294951, 5582.609217354787, 5588.385277619459, 6087.147799308101, 6102.511799056109, 6106.358832322631, 6111.0, 6125.78559750411, 6058.606190597641, 6064.0, 6102.610439773209, 6113.602615829956, 6189.102580125901, 5653.180288858133, 5690.0, 5691.430856914276, 5692.889886472181, 5717.542596592304, 6309.589876658002, 6316.810495685045, 6319.52603554726, 6319.842003949938, 6329.525285603599, 5842.561807864342, 5905.822825315247, 5919.4968427684125, 5984.3417224105315, 5988.0, 6128.78549250783, 6130.948521380002, 6156.661383623944, 6189.0, 6191.845203869849, 6074.696265186723, 6095.030038230458, 6099.521645064548, 6111.40942266768, 6115.850337076409, 5949.196858424144, 6057.182280392179, 6131.325554189036, 6145.324014358417, 6170.074488826622, 4789.4971028042255, 4814.446338671098, 4822.107910036654, 4824.541668541483, 4827.61379089672, 4317.373980772833, 4322.913541729148, 4349.630281426051, 4361.214981303396, 4445.377647129404, 5690.715464226772, 5717.0, 5719.971400143056, 5727.942720572741, 5733.88532229353, 6179.567430279927, 6205.317415084337, 6207.379262073757, 6216.875662486816, 6232.815765004634, 5670.829875103671, 5683.403242659544, 5683.857903552362, 5692.459216374438, 5695.686737229492, 4958.727270000185, 5168.948310516922, 5192.61055420845, 5251.894962100737, 5298.70857102863, 6265.655388953652, 6306.432421082033, 6341.4609758170145, 6345.460635845912, 6350.936490635035, 6176.382361763787, 6178.0, 6184.257889053162, 6190.164327815687, 6194.287656919331, 6156.445919867055, 6168.920438923081, 6239.875202495834, 6311.652859092794, 6325.304216536269, 6039.154518367344, 6069.453749162597, 6080.635161890301, 6111.480524155497, 6129.141920131096, 6130.005417306534, 6164.229471316085, 6184.350643182401, 6184.81445556634, 6201.596896201732, 5472.945270547243, 5524.66851988882, 5552.305961754781, 5902.586818922634, 5970.0, 5516.641418307797, 5873.530117590668, 5875.676837773793, 5924.733386997682, 5996.730147143302, 4999.225120106389, 5585.134304182858, 5793.362730099601, 5807.738651760596, 5835.766569337349, 5008.974955125201, 5939.376365481735, 5943.138244954544, 5953.434423729739, 5967.910481342697, 5624.521915637053, 5730.684812335361, 5762.049261871744, 5763.221965034834, 5826.504747096545], "value": 5575.9610881369845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.3049395412926, 481.62433302024414, 529.2009066309873, 542.235448018294, 547.1710358806406, 30548.847255763718, 31614.841925790366, 33824.49263261053, 39829.60170398295, 43631.0, 42333.7883310583, 42493.0, 42842.35736463948, 42852.71441856749, 42901.78549107258, 9710.563024663907, 9893.802123957517, 9894.505274736235, 9909.653162139326, 9921.0, 9687.273454490942, 9797.314188006842, 9799.069088436587, 9799.16707079899, 9800.901990980106, 9801.41191528507, 9810.509474526281, 9829.213662906986, 9847.556859941284, 9864.210863130933, 9729.270304727139, 9793.510324483746, 9808.607655693764, 9810.90189098107, 9812.165965892871, 9715.36850104741, 9740.610375585038, 9741.710697985967, 9753.122219000254, 9776.266779991458, 40730.38904416436, 41030.79484602588, 41136.79431602853, 41158.58841411577, 41178.9705257368, 3295.670432956709, 3314.287428202948, 3347.581552305962, 3380.8985730428126, 3381.408253555618, 30666.693333066607, 31076.844615776776, 31496.685033149603, 32205.194870128435, 32214.355712885612, 3167.160702413862, 3187.378461200067, 3224.226185715435, 3328.766986310959, 3333.183370074323, 298499.0, 302926.485367574, 303227.0, 303367.0, 303386.0, 59185.52036199129, 60211.39788602058, 63759.0, 64710.0, 64787.67606161939, 32947.0, 33223.00330990074, 33321.50017749736, 68026.319736802, 69415.0, 16013.439529616408, 16357.427490037791, 16418.26117824701, 16426.342946282013, 16454.0, 12367.876321236852, 12462.501499940083, 12478.688032799253, 12482.188657737219, 12484.50061997528, 16713.91643041777, 20370.555533336094, 20568.0, 20620.0, 20686.0, 8643.35174861888, 8727.60725767342, 8737.606807693543, 8750.606222719993, 8839.646414143492, 855.4012191465998, 950.1306304731231, 1028.9588416463407, 1035.6634093919506, 1077.8922107789158, 23029.88485057564, 29098.98153564615, 29694.257643559085, 30411.543826842615, 30453.69546304553, 1035.7928414317166, 1037.0977249792577, 1057.7144171073767, 1068.7808999155154, 1105.5577768892508, 14909.0, 15458.995165314444, 15530.115974560418, 15717.842821571638, 15892.364305427885, 686413.0, 689812.0, 690558.0, 690666.0, 691699.0, 57654.13518797221, 58081.70959145177, 58127.41872581305, 58192.0, 58441.0, 1314.4807800918584, 1362.8160198373093, 1379.3999610169608, 1380.8527739365184, 1381.5579014715395, 23995.040198391867, 24668.259952201464, 29760.10719678413, 29930.85034574813, 30130.480427935985, 49704.0, 50052.499475004784, 50198.0, 50225.0, 50351.49648503468, 592403.0, 593876.0, 594373.0, 594698.0265098647, 595109.0, 27035.324116897234, 27122.457550849267, 27394.31514212081, 27456.45087098287, 27541.0, 46979.29531056969, 47319.05361892812, 48388.0, 48443.5155648439, 48750.26874596955, 39305.41041884317, 39344.01639959024, 39501.2099758009, 39503.60496394999, 40852.59147408607, 38475.615243847205, 38876.0, 40201.39697904475, 40264.7986760076, 40651.59348406478, 37478.0, 37584.62415375921, 38588.22823543457, 38741.80629096949, 38883.2223355537, 32540.0, 32595.295823230364, 32718.018459446255, 33950.320993580484, 34297.0, 22062.779372206074, 24939.875300623382, 25161.748382516675, 25237.369065773502, 25689.614655779806], "value": 19737.80499384163, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.50151012155857, 351.62903137190284, 369.9741018128732, 372.22391314110087, 400.6654443539644, 14958.0, 15218.23908804561, 15880.285387157577, 18508.2596696132, 20636.38090857273, 19726.70409943852, 19745.815251084943, 20229.59540809183, 20524.179032838707, 20540.69188962163, 5575.8606034849145, 5979.431953964388, 5981.0, 5982.042873140298, 5991.191189189469, 5011.924821127686, 5063.493650634926, 5892.410758924116, 5969.820905372824, 5977.940220597782, 5660.29246344207, 5908.911366329508, 5910.852228694274, 5910.970445147768, 5913.349531551526, 5245.344331958505, 5551.306086739117, 5661.60368774186, 5829.679367634779, 5837.678927658977, 4932.556069953722, 5012.097822391968, 5050.545450909399, 5055.519725626096, 5059.6458247922665, 24714.876425617756, 25026.49947001068, 25053.37366565832, 25360.619590706156, 25373.0, 2195.9231426899983, 2212.104097840377, 2244.102359056374, 2335.988320058389, 2353.0940587873793, 14141.29293535319, 15122.54632361031, 15211.315490802941, 15357.078575285406, 15382.384704611914, 1773.939953580077, 1790.5523619095227, 1811.936582219616, 1817.954551136232, 1933.4296382567177, 117675.0, 120000.39999800033, 120278.0, 121107.394463028, 123875.0, 10076.949615251877, 10156.695299141038, 10578.57685692579, 10585.41780202081, 10950.178736594788, 12880.484780608858, 12908.0, 12924.935375323063, 12926.0, 12936.547220847226, 7944.880826787603, 8208.876866847002, 8215.794605134919, 8374.623141958626, 8420.663173473115, 8228.670853165806, 8260.215279548433, 8270.545120018456, 8473.449225800303, 8495.108013658477, 5700.7719691212715, 5723.914141287884, 6143.354947730424, 6288.717007734663, 6307.779227727007, 1757.4112672254682, 1777.3601503458744, 1783.4649605118414, 1791.4536066499843, 1818.1909050472677, 905.5970093308546, 906.5648488725449, 913.2009491694768, 930.0327659234456, 999.1856636840952, 20348.389548313575, 20668.0, 20728.792712072987, 20890.895545522177, 20945.58108837815, 951.4006176109007, 956.1396976692344, 966.9468179250209, 1010.2877471382658, 1022.5296363672794, 10703.464826758787, 11137.554497820158, 11152.888471115184, 11338.60314888975, 11369.658910232707, 589202.0, 592738.0363098157, 602416.0, 607125.0, 607832.0, 90154.0, 95605.0, 101508.98491015143, 119678.0, 127078.72921270669, 816.5345752920778, 937.2221056523069, 1008.193445243802, 1008.6923488336128, 1010.3887148275335, 17975.37086202029, 18744.53138671544, 19192.232310707415, 19204.231830726614, 19282.517937051685, 51747.48252517577, 52085.7395713019, 52214.47785522248, 52585.42243732694, 53684.92630147297, 54076.648083798216, 63737.68131159314, 66966.66516667386, 66982.0, 69995.65002174956, 6873.793786186422, 7199.2440793715905, 7220.602866842164, 7443.962780186064, 7786.143524212219, 11898.22661526998, 12108.455119519467, 12514.687132821753, 13050.54323098725, 13283.335833208494, 10605.840912386475, 11062.778744425228, 11140.16448766362, 11245.71885702864, 11394.772104558027, 8714.956425217833, 10627.840582391116, 10772.299800512941, 11169.106471482099, 11358.204925655125, 10772.030517253172, 10876.23866329381, 10919.672409827717, 11315.151363647594, 11407.0, 7107.892107892108, 7227.193201699575, 7298.489105762758, 7347.302006309392, 7474.7757567273065, 9201.263898887939, 10768.569257229936, 11020.0, 11040.447977600927, 11078.833817492905], "value": 9373.656067157326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.638468575199, 1525.2145145250195, 1753.7281721333197, 1891.8486521078314, 1938.4572319750475, 8603.827923441535, 9157.542122893861, 9157.679481218158, 9158.0, 9173.312001599874, 8068.636911338989, 8314.41799074065, 8322.084570697234, 8443.831123377544, 8913.153250441213, 2155.805977462024, 2185.530111026129, 2298.161171172527, 2375.3824005758543, 2386.4391867911027, 2374.0859768988976, 2377.346229786805, 2382.4282172278704, 2387.546366190418, 2388.5461762265113, 2354.0819080558595, 2364.869932153731, 2397.412633904687, 2401.3756423329974, 2401.7238017627933, 2357.0, 2361.1499860050367, 2378.2389635316704, 2379.452725873042, 2380.0955636858057, 2339.9649005264932, 2355.222776483756, 2362.8227882908677, 2366.0535785685865, 2370.253370188402, 8800.295976321879, 9000.684976025874, 9022.86465703015, 9030.50332231727, 9035.096490350978, 5234.502722241381, 5413.26920865682, 5416.458354164592, 5417.5395091416885, 5430.456954304577, 3545.5213546171194, 3699.7040236780995, 3767.6232376762377, 3780.4140358244517, 3790.8294126764363, 1035.7373828130783, 1085.4572713643179, 1107.7009207514006, 1110.3227031510771, 1112.9666110016713, 11962.880371196263, 12034.81947770784, 12054.939725301405, 12064.155509114365, 12066.939665301705, 3821.38857782759, 4405.911881762411, 4759.785809638574, 4763.476017638057, 4768.856934291907, 9834.754131146636, 10049.497525123714, 10107.3430227035, 10156.796864062677, 10157.898421015843, 5392.975334686475, 5395.406505284415, 5404.54061404785, 5405.378386484039, 5416.350037995466, 4729.574338309569, 4861.854144375674, 4942.233953737176, 4958.826441074617, 4959.90080198394, 3662.1577037281572, 3764.284785890672, 3771.9057023574082, 3833.3674943634546, 3899.337112690849, 1075.7687097274124, 1091.9672409827717, 1272.7709012377675, 1274.2290913996899, 1289.1491615533703, 848.5290663681716, 860.6858496648678, 888.5113187746714, 914.4193437167313, 952.3381250031161, 5721.799737009184, 5812.88374232513, 6039.667818270037, 6054.909176362358, 6150.753969841246, 912.6668765900398, 947.7393716727817, 951.1724799424406, 957.9425234485954, 1008.9243306752023, 3896.668783153407, 4013.91972160561, 4026.617471340218, 4088.7546747195265, 4089.345704687236, 10459.372437653765, 10726.141908647289, 10745.40900250478, 10861.2940158891, 10887.129029677766, 10814.35113893169, 10815.83776243357, 10828.187885908588, 10829.241953063367, 10845.945770271255, 7761.0, 8127.187281271826, 8400.117987611335, 8408.117147699526, 8411.579421028924, 5961.2846458425265, 6086.591508755111, 6091.604045737013, 6133.26400831903, 6196.3803619639475, 9740.464274464972, 9927.602895884083, 10159.644412445528, 10271.486425678537, 10295.227857910537, 9871.555779989774, 10106.747331316776, 10107.7473063174, 10381.221408394249, 10489.632862850069, 7953.363730901629, 8155.79610509742, 8411.242988130853, 8419.95790021046, 8430.83138337242, 7572.20491848348, 7839.137694853675, 7848.7645370638975, 8293.33653307746, 8424.283935865275, 7465.701371945279, 7504.512206706547, 7507.812304692208, 7604.0, 7618.466707330434, 7411.2588741125455, 7442.0, 7501.362384197404, 7547.245275472628, 7559.962200189184, 6972.302769722987, 6991.545549539263, 6991.580505169706, 7042.718291268292, 7087.0, 5016.648834581544, 5031.6226283029655, 5037.622178336566, 5045.167547354646, 5166.6125040621355, 4868.61051115917, 4960.652754307308, 5130.256112863689, 5171.405288391883, 5260.736963151904], "value": 4642.120800214498, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [247.29274275571862, 292.38307171867353, 305.81651009394363, 309.2068843416636, 316.4541166487807, 4883.19427294496, 5110.795568177277, 5112.8977420451565, 5123.615728820339, 5154.819581314655, 3874.8643797467093, 4573.817047318112, 4953.835848575582, 4975.577075948549, 5011.970152088401, 3866.3427217372973, 3891.727579069466, 3897.0, 3915.843366265353, 3917.784521851297, 3855.4024126260333, 3935.4096885467125, 3950.4666869972616, 3952.5454572724216, 3957.832439430375, 3009.759219262454, 3069.7083777041257, 3502.7197824174004, 3715.758475699071, 3829.5404551453867, 3859.2281543691233, 3877.592852750449, 3898.5906479819496, 3919.2553414851086, 3943.0, 2939.7207265309976, 3022.909312720622, 3102.674219206996, 3361.932761344784, 3431.7769344992494, 4597.954020459786, 4919.680220785674, 4951.282064100686, 4965.0, 4978.103941290602, 4078.4697989261504, 4357.912841743179, 4378.598848368523, 4399.580230873039, 4446.266366049598, 4464.955350446487, 4576.839810606646, 4817.686850354716, 5193.065248255312, 5352.4915133062295, 3406.489026646023, 3433.1760377509468, 3681.932239650498, 3691.6492933171576, 3694.8152592370275, 4757.524247575249, 4874.000829829912, 5062.291279220912, 5104.719240441774, 5614.550835933115, 3282.622498412665, 3559.875404360887, 3610.548681414823, 3703.518542589446, 3724.3110024645525, 3337.4493208620793, 3687.244114956481, 3779.3764028934916, 3789.5642001169667, 3807.238552289498, 4184.686148538872, 4368.301071828492, 4375.759333236639, 4384.320430333303, 4428.822847086145, 4937.5556199942175, 5261.500157485033, 5291.761870715827, 5308.309919710413, 5329.974609648309, 1215.5198696515004, 1281.3144967442374, 1284.3642397013352, 1287.896968242557, 1288.2013151845915, 747.3796748698567, 771.733751855609, 782.3897360059163, 795.0538858758059, 798.1101072304455, 3550.6449355064287, 3758.4174452959833, 4142.565030671736, 4162.876023473646, 4236.9788151059665, 4455.0, 4473.552644735565, 4487.52217031803, 4519.480259770168, 4549.613282870927, 3340.6492318306714, 3588.6052534221217, 4061.5329237137516, 4093.467849179647, 4098.442591815091, 2088.488320361491, 2308.230123851385, 2377.669883514166, 2382.9404264893515, 2865.555838844982, 4986.282476050561, 5656.236408084938, 5670.476637896179, 5670.5747068969995, 5682.431756824284, 4383.517813040563, 5581.441855814386, 5607.775529070801, 5617.354004289477, 5618.91571626426, 5368.8389348319615, 5570.0, 5574.442555744393, 5587.664740115606, 5601.383847776659, 4582.977085114553, 4659.138059459011, 5360.383555891122, 5365.946340536545, 5436.130219165073, 4721.386219791405, 5338.626296159232, 5375.715320988643, 5378.5966052547, 5407.945920540744, 4950.816560006789, 5039.622028347815, 5254.763535640982, 5469.890602188014, 5575.386707462257, 3025.5007923693224, 3529.8764543240864, 3670.6879915207505, 3679.356112680217, 3687.916327275081, 4770.332153498443, 4781.995780886053, 4959.429665588504, 5399.271098401666, 5485.9725701371235, 4675.976620116878, 4707.246840505502, 4855.562999329936, 5106.974465127651, 5240.0, 5198.752299448181, 5218.478152184751, 5225.615211968755, 5228.111221092499, 5235.591627851231, 4277.401163837003, 4311.1377724454605, 5114.565261952627, 5133.79464821403, 5180.611454140879, 4437.8890527735775, 4980.850574482772, 5112.412072611697, 5249.685018898878, 5256.816011439734, 4541.636669066533, 5109.9233511498105, 5131.255967884561, 5148.730556096831, 5158.406783219978], "value": 3764.6760371955443, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.590238393852, 702.7189124350259, 721.4480922094599, 759.1952530317867, 783.5612057247941, 14510.347034383438, 14542.636434089127, 14543.200123993176, 14553.41786328547, 14873.553793386202, 13362.265075420848, 13740.381682824273, 13782.0, 13782.931085344584, 13823.585292441217, 667.0594461808851, 694.6249025526209, 834.3825569078898, 847.1613103027988, 860.5052095045374, 862.3316929379719, 869.4305230074311, 873.1007062725403, 874.5190145420025, 875.7504111328273, 920.2729843423688, 921.0789210789211, 921.8018126102886, 922.7093465558361, 923.487464457226, 715.2418436457319, 737.9557226566424, 913.4747520175926, 915.6428992692855, 915.7161280003187, 550.6806052489546, 551.0604419464803, 552.1248820619323, 670.7115940145735, 690.3683129936103, 14759.77860332096, 14878.70242595153, 14883.851161488356, 14888.404463821435, 14946.70106597862, 13573.1856088635, 13728.862711372858, 13830.377633006437, 13921.58235252944, 14229.359678814375, 12301.56944506947, 12515.812262815974, 12606.621801345975, 12617.242965422103, 13140.802887956688, 4508.053308805155, 4606.976965115186, 4624.560666736655, 4632.745199014053, 4718.622510199176, 90104.0, 105339.47330263376, 108909.0, 114799.85200147975, 114852.0, 10711.517981690688, 10928.726781830359, 11216.66350009501, 11285.887141128647, 11373.658790236306, 21310.254141104986, 21437.785622143892, 21452.0, 21460.712357258613, 21461.78538214598, 7769.417293702995, 7863.0, 7901.762947111596, 8055.4763940344865, 8127.0, 4204.66362690984, 4325.848595299212, 4344.370066340363, 4354.325079612602, 4489.304157855472, 3277.967220327766, 3373.308471763283, 3374.5106959490736, 3380.2394461246513, 3380.864765409405, 645.6481217736344, 652.46171908175, 661.2825084783065, 668.8963210702349, 674.6458109492555, 517.531633871347, 533.9155460725405, 543.2476020711343, 584.8917950179231, 586.5923183387505, 7239.674214660353, 7876.921230787733, 8727.781805454788, 8845.867311990325, 8955.507447090473, 520.5133200457584, 557.2783245696833, 615.9384061593894, 626.1265534579236, 626.7336382037615, 3775.3959366501226, 4288.2495563276925, 4397.186520493655, 4404.757738324423, 4530.29780384041, 84045.57977210075, 84171.15828841634, 88758.66861997075, 156581.43418565896, 160882.1955890213, 100392.0, 124325.37837310755, 129766.0, 137579.0, 139766.0, 53897.0, 110848.44575777231, 111478.0, 115819.8418015809, 119052.40473797575, 8465.0, 8492.575371231538, 8620.224179823846, 8709.738707838775, 8723.345749068718, 62404.68797656164, 62480.375196247456, 63741.0, 63777.0, 64982.35017649763, 72069.63965180141, 91474.3641017434, 92097.53951230469, 93277.0, 96401.093819519, 11244.55021799119, 11306.321620702454, 11480.368579727861, 11698.824517632413, 11730.0, 10713.517891695048, 12145.672237465702, 12262.570810021607, 12419.751604967669, 12519.496100780063, 11478.0, 11685.0, 11947.701307467383, 11958.64124076279, 12044.819327710267, 11216.775664486502, 11934.462949167135, 13534.0, 13868.514601989285, 14185.219812910389, 13581.0, 13759.380827862971, 13836.654083647989, 13921.512747053805, 14257.083895547496, 11070.778584428428, 11320.547178112784, 11475.254108482923, 11511.07911367072, 11727.237729547553, 10353.378797271887, 11359.09127269833, 11491.367974761468, 11659.0, 11675.241109327866], "value": 7515.39490305061, "unit": "score"}], "name": "dromaeo_css", "value": 7166.857952854863, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0, 112.0, 112.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 114.0, 114.0, 149.0, 113.0, 113.0, 114.0, 114.0, 145.0, 139.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 183.0, 187.0, 185.0, 182.0, 183.0, 184.0, 180.0, 183.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 59.0, 88.0, 62.0, 60.0, 60.0, 92.0, 82.0, 57.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 91.0, 70.0, 89.0, 101.0, 129.0, 67.0, 70.0, 90.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 88.0, 84.0, 87.0, 84.0, 87.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 85.0, 88.0, 85.0, 84.0, 83.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 53.0, 54.0, 54.0, 55.0, 53.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 67.0, 73.0, 70.0, 68.0, 69.0, 67.0, 67.0, 74.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 89.0, 86.0, 88.0, 85.0, 89.0, 91.0, 88.0, 92.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 143.0, 145.0, 144.0, 145.0, 147.0, 146.0, 176.0, 143.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 173.0, 171.0, 170.0, 168.0, 176.0, 236.0, 197.0, 169.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 83.0, 88.0, 88.0, 88.0, 68.0, 69.0, 69.0, 70.0], "value": 76.6, "unit": "score"}], "name": "kraken", "value": 1461.6, "alertThreshold": 2.0}]} 09:53:24 INFO - Return code: 0 09:53:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:53:24 INFO - # TBPL SUCCESS # 09:53:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:53:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:53:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:53:25 INFO - 2016-10-04 09:53:25.008 screenresolution[1948:13988] starting screenresolution argv=screenresolution get 09:53:25 INFO - 2016-10-04 09:53:25.011 screenresolution[1948:13988] Display 0: 1600x1200x32@60 09:53:25 INFO - 2016-10-04 09:53:25.017 screenresolution[1949:13991] starting screenresolution argv=screenresolution list 09:53:25 INFO - Available Modes on Display 0 09:53:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:53:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:53:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:53:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:53:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:53:25 INFO - Intel Iris: 09:53:25 INFO - Chipset Model: Intel Iris 09:53:25 INFO - Type: GPU 09:53:25 INFO - Bus: Built-In 09:53:25 INFO - VRAM (Dynamic, Max): 1536 MB 09:53:25 INFO - Vendor: Intel (0x8086) 09:53:25 INFO - Device ID: 0x0a2e 09:53:25 INFO - Revision ID: 0x0009 09:53:25 INFO - Displays: 09:53:25 INFO - Display: 09:53:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:53:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:53:25 INFO - Display Serial Number: 1600x1200 60 09:53:25 INFO - Main Display: Yes 09:53:25 INFO - Mirror: Off 09:53:25 INFO - Online: Yes 09:53:25 INFO - Rotation: Supported 09:53:25 INFO - Return code: 0 09:53:25 INFO - Running post-action listener: _resource_record_post_action 09:53:25 INFO - [mozharness: 2016-10-04 16:53:25.256259Z] Finished run-tests step (success) 09:53:25 INFO - Running post-run listener: _resource_record_post_run 09:53:25 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 815104; Write bytes: 706794496; Read time: 12; Write time: 2048 09:53:25 INFO - TinderboxPrint: CPU usage
53.7% 09:53:25 INFO - TinderboxPrint: I/O read bytes / time
815,104 / 12 09:53:25 INFO - TinderboxPrint: I/O write bytes / time
706,794,496 / 2,048 09:53:25 INFO - TinderboxPrint: CPU idle
2,248.1 (46.3%) 09:53:25 INFO - TinderboxPrint: CPU system
972.2 (20.0%) 09:53:25 INFO - TinderboxPrint: CPU user
1,633.4 (33.7%) 09:53:25 INFO - TinderboxPrint: Swap in / out
408,305,664 / 0 09:53:25 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393261568; Write bytes: 389683200; Read time: 29534; Write time: 700 09:53:25 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 815104; Write bytes: 293737984; Read time: 12; Write time: 1293 09:53:25 INFO - Running post-run listener: _upload_blobber_files 09:53:25 INFO - Blob upload gear active. 09:53:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:25 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 09:53:25 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:53:25 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:53:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:27 INFO - (blobuploader) - INFO - Done attempting. 09:53:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:53:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:53:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:28 INFO - (blobuploader) - INFO - Done attempting. 09:53:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:53:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:53:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:31 INFO - (blobuploader) - INFO - Done attempting. 09:53:31 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:31 INFO - Return code: 0 09:53:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/467700e187208c1de2d4241eb1fe1350f67f4411739ccfa4896016833d4a57ebeb32e94a9789e2c076b227734dbda8ce602cede1cb7b41549ca7e588af0d7b73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7480a5d386e8bfb685572ca953d5288ffdef7c617a2197cbcd030380856df216f19bf82272cb7cae5d0f5c0aad2f3f49e0f7ac62c6cb995f4f9a039e49a8198b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a75b4bf12cedc4d689ecbe95049fda16fe3d9b7785fefb6d1c3333adbc309281ccaf460aad06b7d495fe4f1e283e95ef015af1fe5896cc30d60e8e73fa4fa3cd"} 09:53:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:31 INFO - Contents: 09:53:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/467700e187208c1de2d4241eb1fe1350f67f4411739ccfa4896016833d4a57ebeb32e94a9789e2c076b227734dbda8ce602cede1cb7b41549ca7e588af0d7b73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7480a5d386e8bfb685572ca953d5288ffdef7c617a2197cbcd030380856df216f19bf82272cb7cae5d0f5c0aad2f3f49e0f7ac62c6cb995f4f9a039e49a8198b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a75b4bf12cedc4d689ecbe95049fda16fe3d9b7785fefb6d1c3333adbc309281ccaf460aad06b7d495fe4f1e283e95ef015af1fe5896cc30d60e8e73fa4fa3cd"} 09:53:31 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:31 INFO - Copying logs to upload dir... 09:53:31 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.920921 ========= master_lag: 1.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-04 09:53:32.381709) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 09:53:32.385896) ========= 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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/Fx-Team/sha512/467700e187208c1de2d4241eb1fe1350f67f4411739ccfa4896016833d4a57ebeb32e94a9789e2c076b227734dbda8ce602cede1cb7b41549ca7e588af0d7b73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7480a5d386e8bfb685572ca953d5288ffdef7c617a2197cbcd030380856df216f19bf82272cb7cae5d0f5c0aad2f3f49e0f7ac62c6cb995f4f9a039e49a8198b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a75b4bf12cedc4d689ecbe95049fda16fe3d9b7785fefb6d1c3333adbc309281ccaf460aad06b7d495fe4f1e283e95ef015af1fe5896cc30d60e8e73fa4fa3cd"} build_url:https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010843 build_url: 'https://queue.taskcluster.net/v1/task/VKFvTmpGQUGxOwy9NiqPeA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/467700e187208c1de2d4241eb1fe1350f67f4411739ccfa4896016833d4a57ebeb32e94a9789e2c076b227734dbda8ce602cede1cb7b41549ca7e588af0d7b73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7480a5d386e8bfb685572ca953d5288ffdef7c617a2197cbcd030380856df216f19bf82272cb7cae5d0f5c0aad2f3f49e0f7ac62c6cb995f4f9a039e49a8198b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a75b4bf12cedc4d689ecbe95049fda16fe3d9b7785fefb6d1c3333adbc309281ccaf460aad06b7d495fe4f1e283e95ef015af1fe5896cc30d60e8e73fa4fa3cd"}' ========= master_lag: 0.21 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 09:53:32.605042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-10-04 09:53:32.605371) ========= 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.9sjvQAVDzk/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.rwoTD1JSLN/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005304 ========= master_lag: 4.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-10-04 09:53:36.657626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 09:53:36.658017) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 09:53:36.660114) ========= ========= Total master_lag: 5.64 =========