builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0344 starttime: 1476153886.98 results: success (0) buildid: 20161010185046 builduid: cc4bd7c192ca4d9d8f2780bd2a0a16b8 revision: 2bd339bcc38f2ba3c1afcedd261cf7134b1619df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:46.981737) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:46.982189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:46.982462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:47.006509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:47.006933) ========= 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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-10 19:44:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2016-10-10 19:44:47 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.183455 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:47.212664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:47.212987) ========= 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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.026592 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:47.261676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 19:44:47.262038) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2bd339bcc38f2ba3c1afcedd261cf7134b1619df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 2bd339bcc38f2ba3c1afcedd261cf7134b1619df --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4FFR4Jn0Vn/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.naCl6XgXai/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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-10 19:44:47,346 truncating revision to first 12 chars 2016-10-10 19:44:47,346 Setting DEBUG logging. 2016-10-10 19:44:47,346 attempt 1/10 2016-10-10 19:44:47,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2bd339bcc38f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 19:44:48,874 unpacking tar archive at: autoland-2bd339bcc38f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.814835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-10 19:44:49.098464) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:49.098766) ========= script_repo_revision: 2bd339bcc38f2ba3c1afcedd261cf7134b1619df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:49.099165) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:49.099426) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 19:44:49.117121) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-10 19:44:49.117406) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4FFR4Jn0Vn/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.naCl6XgXai/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:44:49 INFO - MultiFileLogger online at 20161010 19:44:49 in /builds/slave/test 19:44:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 19:44:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:44:49 INFO - {'append_to_log': False, 19:44:49 INFO - 'base_work_dir': '/builds/slave/test', 19:44:49 INFO - 'blob_upload_branch': 'Autoland', 19:44:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:44:49 INFO - 'branch': 'Autoland', 19:44:49 INFO - 'buildbot_json_path': 'buildprops.json', 19:44:49 INFO - 'config_files': ('talos/mac_config.py',), 19:44:49 INFO - 'default_actions': ('clobber', 19:44:49 INFO - 'read-buildbot-config', 19:44:49 INFO - 'download-and-extract', 19:44:49 INFO - 'populate-webroot', 19:44:49 INFO - 'create-virtualenv', 19:44:49 INFO - 'install', 19:44:49 INFO - 'run-tests'), 19:44:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:44:49 INFO - 'download_minidump_stackwalk': True, 19:44:49 INFO - 'download_symbols': 'ondemand', 19:44:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:44:49 INFO - 'tooltool.py': '/tools/tooltool.py', 19:44:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:44:49 INFO - '/tools/misc-python/virtualenv.py')}, 19:44:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:44:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:44:49 INFO - 'installer_path': 'installer.exe', 19:44:49 INFO - 'log_level': 'info', 19:44:49 INFO - 'log_name': 'talos', 19:44:49 INFO - 'log_to_console': True, 19:44:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:44:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:44:49 INFO - 'opt_config_files': (), 19:44:49 INFO - 'pip_index': False, 19:44:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:44:49 INFO - 'cmd': ('bash', 19:44:49 INFO - '-c', 19:44:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:44:49 INFO - 'enabled': True, 19:44:49 INFO - 'halt_on_failure': False, 19:44:49 INFO - 'name': 'check_screen_resolution'},), 19:44:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:44:49 INFO - 'cmd': ('bash', 19:44:49 INFO - '-c', 19:44:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:44:49 INFO - 'enabled': True, 19:44:49 INFO - 'halt_on_failure': False, 19:44:49 INFO - 'name': 'check_screen_resolution'},), 19:44:49 INFO - 'run_cmd_checks_enabled': True, 19:44:49 INFO - 'sps_profile': False, 19:44:49 INFO - 'sps_profile_interval': 0, 19:44:49 INFO - 'suite': 'dromaeojs', 19:44:49 INFO - 'system_bits': '32', 19:44:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:44:49 INFO - 'title': 't-yosemite-r7-0344', 19:44:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:44:49 INFO - 'use_talos_json': True, 19:44:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:44:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:44:49 INFO - 'work_dir': 'build'} 19:44:49 INFO - [mozharness: 2016-10-11 02:44:49.324561Z] Running clobber step. 19:44:49 INFO - Running pre-action listener: _resource_record_pre_action 19:44:49 INFO - Running main action method: clobber 19:44:49 INFO - rmtree: /builds/slave/test/build 19:44:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:44:51 INFO - Running post-action listener: _resource_record_post_action 19:44:51 INFO - [mozharness: 2016-10-11 02:44:51.523570Z] Finished clobber step (success) 19:44:51 INFO - [mozharness: 2016-10-11 02:44:51.523758Z] Running read-buildbot-config step. 19:44:51 INFO - Running pre-action listener: _resource_record_pre_action 19:44:51 INFO - Running main action method: read_buildbot_config 19:44:51 INFO - Using buildbot properties: 19:44:51 INFO - { 19:44:51 INFO - "project": "", 19:44:51 INFO - "product": "firefox", 19:44:51 INFO - "script_repo_revision": "production", 19:44:51 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 19:44:51 INFO - "repository": "", 19:44:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 19:44:51 INFO - "buildid": "20161010185046", 19:44:51 INFO - "pgo_build": "False", 19:44:51 INFO - "basedir": "/builds/slave/test", 19:44:51 INFO - "buildnumber": 275, 19:44:51 INFO - "slavename": "t-yosemite-r7-0344", 19:44:51 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 19:44:51 INFO - "platform": "yosemite_r7", 19:44:51 INFO - "scheduler": "tests-autoland-macosx64-talos", 19:44:51 INFO - "branch": "autoland", 19:44:51 INFO - "repo_path": "integration/autoland", 19:44:51 INFO - "revision": "2bd339bcc38f2ba3c1afcedd261cf7134b1619df", 19:44:51 INFO - "stage_platform": "macosx64", 19:44:51 INFO - "builduid": "cc4bd7c192ca4d9d8f2780bd2a0a16b8", 19:44:51 INFO - "slavebuilddir": "test" 19:44:51 INFO - } 19:44:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 19:44:51 INFO - Running post-action listener: _resource_record_post_action 19:44:51 INFO - [mozharness: 2016-10-11 02:44:51.529297Z] Finished read-buildbot-config step (success) 19:44:51 INFO - [mozharness: 2016-10-11 02:44:51.529449Z] Running download-and-extract step. 19:44:51 INFO - Running pre-action listener: _resource_record_pre_action 19:44:51 INFO - Running main action method: download_and_extract 19:44:51 INFO - mkdir: /builds/slave/test/build/tests 19:44: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')]} 19:44:51 INFO - trying https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 19:44:51 INFO - Downloading https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/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 19:44:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/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 19:44:52 INFO - Downloaded 1199 bytes. 19:44:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 19:44:52 INFO - Using the following test package requirements: 19:44:52 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 19:44:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:44:52 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 19:44:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:44:52 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 19:44:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:44:52 INFO - u'jsshell-mac.zip'], 19:44:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:44:52 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 19:44:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 19:44:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:44:52 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 19:44:52 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:44:52 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 19:44:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:44:52 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 19:44:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:44:52 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 19:44:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:44:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 19:44:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:44:52 INFO - Fetch https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 19:44:53 INFO - Http code: 200 19:44:53 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 19:44:53 INFO - x-amz-cf-id: tQP_mKIrybdRulEWn6Jtx1s54_ttKPE7I9snkOKYCxhl7fGfrXyrtg== 19:44:53 INFO - x-amz-version-id: k2cJKsOMOMJ.qLilTiR5BwTX9b_hg6G3 19:44:53 INFO - Expected file size: 16497365 19:44:53 INFO - Obtained file size: 16497365 19:45:00 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 19:45:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 19:45:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:45:00 INFO - Fetch https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 19:45:00 INFO - Http code: 200 19:45:00 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 19:45:00 INFO - x-amz-cf-id: dcfpiYqYXdM6deEzHIOflTQU9pe9e-UEbvKaeRthld7kM3V8hJw_qA== 19:45:00 INFO - x-amz-version-id: k2cJKsOMOMJ.qLilTiR5BwTX9b_hg6G3 19:45:01 INFO - Expected file size: 16497365 19:45:01 INFO - Obtained file size: 16497365 19:45:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 19:45:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:45:07 INFO - Fetch https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 19:45:08 INFO - Http code: 200 19:45:08 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 19:45:08 INFO - x-amz-cf-id: -IKJtyo0hgaCp2MmMIWIZpk84u3bIM8eGoGqfLxdOkCM8cRziH0-DA== 19:45:08 INFO - x-amz-version-id: U5MU.tc9K9agHUQbg2OBRww45RzvrtXF 19:45:08 INFO - Expected file size: 14409006 19:45:08 INFO - Obtained file size: 14409006 19:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:09 INFO - trying https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:45:09 INFO - Downloading https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 19:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/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 19:45:12 INFO - Downloaded 111690011 bytes. 19:45:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:45:12 INFO - mkdir: /builds/slave/test/properties 19:45:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:45:12 INFO - Writing to file /builds/slave/test/properties/build_url 19:45:12 INFO - Contents: 19:45:12 INFO - build_url:https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:45:12 INFO - Running post-action listener: _resource_record_post_action 19:45:12 INFO - Running post-action listener: set_extra_try_arguments 19:45:12 INFO - [mozharness: 2016-10-11 02:45:12.794980Z] Finished download-and-extract step (success) 19:45:12 INFO - [mozharness: 2016-10-11 02:45:12.795136Z] Running populate-webroot step. 19:45:12 INFO - Running pre-action listener: _resource_record_pre_action 19:45:12 INFO - Running main action method: populate_webroot 19:45:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:45:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:45:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:45:12 INFO - '--tppagecycles', 19:45:12 INFO - '7'], 19:45:12 INFO - 'tests': ['tsvgm']}}, 19:45:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:45:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:45:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:45:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:45:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:12 INFO - 'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:45:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:45:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:12 INFO - 'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['damp', 'tps']}, 19:45:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:12 INFO - 'tests': ['damp', 'tps']}, 19:45:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['dromaeo_dom']}, 19:45:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:45:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['basic_compositor_video']}, 19:45:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:45:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['a11yr', 19:45:12 INFO - 'ts_paint', 19:45:12 INFO - 'tpaint', 19:45:12 INFO - 'sessionrestore', 19:45:12 INFO - 'sessionrestore_no_auto_restore', 19:45:12 INFO - 'tabpaint']}, 19:45:12 INFO - 'other-e10s': {'tests': ['a11yr', 19:45:12 INFO - 'ts_paint', 19:45:12 INFO - 'tpaint', 19:45:12 INFO - 'sessionrestore', 19:45:12 INFO - 'sessionrestore_no_auto_restore', 19:45:12 INFO - 'tabpaint']}, 19:45:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:45:12 INFO - 'ts_paint', 19:45:12 INFO - 'tpaint', 19:45:12 INFO - 'sessionrestore', 19:45:12 INFO - 'sessionrestore_no_auto_restore', 19:45:12 INFO - 'tabpaint']}, 19:45:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:45:12 INFO - 'ts_paint', 19:45:12 INFO - 'tpaint', 19:45:12 INFO - 'sessionrestore', 19:45:12 INFO - 'sessionrestore_no_auto_restore', 19:45:12 INFO - 'tabpaint']}, 19:45:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['a11yr', 19:45:12 INFO - 'ts_paint', 19:45:12 INFO - 'tpaint', 19:45:12 INFO - 'sessionrestore', 19:45:12 INFO - 'sessionrestore_no_auto_restore', 19:45:12 INFO - 'tabpaint']}, 19:45:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['a11yr', 19:45:12 INFO - 'ts_paint', 19:45:12 INFO - 'tpaint', 19:45:12 INFO - 'sessionrestore', 19:45:12 INFO - 'sessionrestore_no_auto_restore', 19:45:12 INFO - 'tabpaint']}, 19:45:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['tsvgx', 19:45:12 INFO - 'tsvgr_opacity', 19:45:12 INFO - 'tart', 19:45:12 INFO - 'tscrollx', 19:45:12 INFO - 'cart']}, 19:45:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:45:12 INFO - 'tsvgr_opacity', 19:45:12 INFO - 'tart', 19:45:12 INFO - 'tscrollx', 19:45:12 INFO - 'cart']}, 19:45:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:12 INFO - 'talos_options': ['--disable-e10s'], 19:45:12 INFO - 'tests': ['tp5o']}, 19:45:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:12 INFO - 'tests': ['tp5o']}, 19:45:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:12 INFO - 'talos_options': ['--disable-e10s', 19:45:12 INFO - '--xperf_path', 19:45:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:45:12 INFO - 'tests': ['tp5n']}, 19:45:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:12 INFO - 'talos_options': ['--xperf_path', 19:45:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:45:12 INFO - 'tests': ['tp5n']}}, 19:45:12 INFO - 'talos.zip': {'path': '', 19:45:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:45:12 INFO - Running post-action listener: _resource_record_post_action 19:45:12 INFO - [mozharness: 2016-10-11 02:45:12.814027Z] Finished populate-webroot step (success) 19:45:12 INFO - [mozharness: 2016-10-11 02:45:12.814164Z] Running create-virtualenv step. 19:45:12 INFO - Running pre-action listener: _resource_record_pre_action 19:45:12 INFO - Running main action method: create_virtualenv 19:45:12 INFO - Creating virtualenv /builds/slave/test/build/venv 19:45:12 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 19:45:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:45:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:45:12 INFO - Using real prefix '/tools/python27' 19:45:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:45:13 INFO - Installing distribute.............................................................................................................................................................................................done. 19:45:16 INFO - Installing pip.................done. 19:45:16 INFO - Return code: 0 19:45:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:45:16 INFO - Reading from file tmpfile_stdout 19:45:16 INFO - Output received: 19:45:16 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) 19:45:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:45:16 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')]} 19:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:16 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')]} 19:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:16 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 0x103ddd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4825246f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, '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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:45:16 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 19:45:16 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 19:45:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:45:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:16 INFO - 'HOME': '/Users/cltbld', 19:45:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:16 INFO - 'LOGNAME': 'cltbld', 19:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:16 INFO - 'MOZ_NO_REMOTE': '1', 19:45:16 INFO - 'NO_EM_RESTART': '1', 19:45:16 INFO - 'PAGER': '/bin/cat', 19:45:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:16 INFO - 'PWD': '/builds/slave/test', 19:45:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:16 INFO - 'SHELL': '/bin/bash', 19:45:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:45:16 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:45:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:16 INFO - 'USER': 'cltbld', 19:45:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:16 INFO - 'XPC_FLAGS': '0x0', 19:45:16 INFO - 'XPC_SERVICE_NAME': '0', 19:45:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:17 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 19:45:17 INFO - Cleaning up... 19:45:17 INFO - Return code: 0 19:45:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:17 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 0x103ddd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4825246f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, '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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:45:17 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 19:45:17 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 19:45:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:45:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:17 INFO - 'HOME': '/Users/cltbld', 19:45:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:17 INFO - 'LOGNAME': 'cltbld', 19:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:17 INFO - 'MOZ_NO_REMOTE': '1', 19:45:17 INFO - 'NO_EM_RESTART': '1', 19:45:17 INFO - 'PAGER': '/bin/cat', 19:45:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:17 INFO - 'PWD': '/builds/slave/test', 19:45:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:17 INFO - 'SHELL': '/bin/bash', 19:45:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:45:17 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:45:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:17 INFO - 'USER': 'cltbld', 19:45:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:17 INFO - 'XPC_FLAGS': '0x0', 19:45:17 INFO - 'XPC_SERVICE_NAME': '0', 19:45:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:17 INFO - Downloading/unpacking psutil>=3.1.1 19:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:45:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:45:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:45:20 INFO - Installing collected packages: psutil 19:45:20 INFO - Running setup.py install for psutil 19:45:20 INFO - building 'psutil._psutil_osx' extension 19:45:20 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 19:45:21 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 19:45:21 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 19:45:21 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 19:45:21 INFO - building 'psutil._psutil_posix' extension 19:45:21 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 19:45:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:45:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:45:21 INFO - ^ 19:45:21 INFO - 1 warning generated. 19:45:21 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 19:45:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:45:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:45:21 INFO - Successfully installed psutil 19:45:21 INFO - Cleaning up... 19:45:21 INFO - Return code: 0 19:45:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:45:21 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')]} 19:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:21 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')]} 19:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:21 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 0x103ddd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4825246f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, '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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:45:21 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 19:45:21 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 19:45:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:45:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:21 INFO - 'HOME': '/Users/cltbld', 19:45:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:21 INFO - 'LOGNAME': 'cltbld', 19:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:21 INFO - 'MOZ_NO_REMOTE': '1', 19:45:21 INFO - 'NO_EM_RESTART': '1', 19:45:21 INFO - 'PAGER': '/bin/cat', 19:45:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:21 INFO - 'PWD': '/builds/slave/test', 19:45:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:21 INFO - 'SHELL': '/bin/bash', 19:45:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:45:21 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:45:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:21 INFO - 'USER': 'cltbld', 19:45:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:21 INFO - 'XPC_FLAGS': '0x0', 19:45:21 INFO - 'XPC_SERVICE_NAME': '0', 19:45:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:45:22 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 19:45:22 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 19:45:22 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 19:45:22 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 19:45:22 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 19:45:22 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 19:45:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:45:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:45:24 INFO - Installing collected packages: mozsystemmonitor 19:45:24 INFO - Running setup.py install for mozsystemmonitor 19:45:24 INFO - Successfully installed mozsystemmonitor 19:45:24 INFO - Cleaning up... 19:45:25 INFO - Return code: 0 19:45:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:45:25 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')]} 19:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:25 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')]} 19:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:25 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 0x103ddd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4825246f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, '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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:45:25 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 19:45:25 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 19:45:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:45:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:25 INFO - 'HOME': '/Users/cltbld', 19:45:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:25 INFO - 'LOGNAME': 'cltbld', 19:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:25 INFO - 'MOZ_NO_REMOTE': '1', 19:45:25 INFO - 'NO_EM_RESTART': '1', 19:45:25 INFO - 'PAGER': '/bin/cat', 19:45:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:25 INFO - 'PWD': '/builds/slave/test', 19:45:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:25 INFO - 'SHELL': '/bin/bash', 19:45:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:45:25 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:45:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:25 INFO - 'USER': 'cltbld', 19:45:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:25 INFO - 'XPC_FLAGS': '0x0', 19:45:25 INFO - 'XPC_SERVICE_NAME': '0', 19:45:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:25 INFO - Downloading/unpacking jsonschema==2.5.1 19:45:25 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 19:45:25 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 19:45:25 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 19:45:25 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 19:45:25 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 19:45:25 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 19:45:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:45:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:45:27 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 19:45:27 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 19:45:27 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 19:45:27 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 19:45:27 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 19:45:27 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 19:45:28 INFO - Downloading functools32-3.2.3-2.tar.gz 19:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:45:28 INFO - warning: no files found matching '*.txt' 19:45:28 INFO - no previously-included directories found matching 'build' 19:45:28 INFO - no previously-included directories found matching 'dist' 19:45:28 INFO - no previously-included directories found matching '.git*' 19:45:28 INFO - Installing collected packages: jsonschema, functools32 19:45:28 INFO - Running setup.py install for functools32 19:45:28 INFO - warning: no files found matching '*.txt' 19:45:28 INFO - no previously-included directories found matching 'build' 19:45:28 INFO - no previously-included directories found matching 'dist' 19:45:28 INFO - no previously-included directories found matching '.git*' 19:45:28 INFO - Successfully installed jsonschema functools32 19:45:28 INFO - Cleaning up... 19:45:28 INFO - Return code: 0 19:45:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:45:28 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')]} 19:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:28 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')]} 19:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:28 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 0x103ddd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4825246f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, '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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:45:28 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 19:45:28 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 19:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:28 INFO - 'HOME': '/Users/cltbld', 19:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:28 INFO - 'LOGNAME': 'cltbld', 19:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:28 INFO - 'MOZ_NO_REMOTE': '1', 19:45:28 INFO - 'NO_EM_RESTART': '1', 19:45:28 INFO - 'PAGER': '/bin/cat', 19:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:28 INFO - 'PWD': '/builds/slave/test', 19:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:28 INFO - 'SHELL': '/bin/bash', 19:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:45:28 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:28 INFO - 'USER': 'cltbld', 19:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:28 INFO - 'XPC_FLAGS': '0x0', 19:45:28 INFO - 'XPC_SERVICE_NAME': '0', 19:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:45:28 INFO - Cleaning up... 19:45:28 INFO - Return code: 0 19:45:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:45:28 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')]} 19:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:28 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')]} 19:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:28 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 0x103ddd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4825246f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, '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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:45:28 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 19:45:28 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 19:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:28 INFO - 'HOME': '/Users/cltbld', 19:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:28 INFO - 'LOGNAME': 'cltbld', 19:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:28 INFO - 'MOZ_NO_REMOTE': '1', 19:45:28 INFO - 'NO_EM_RESTART': '1', 19:45:28 INFO - 'PAGER': '/bin/cat', 19:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:28 INFO - 'PWD': '/builds/slave/test', 19:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:28 INFO - 'SHELL': '/bin/bash', 19:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:45:28 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:28 INFO - 'USER': 'cltbld', 19:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:28 INFO - 'XPC_FLAGS': '0x0', 19:45:28 INFO - 'XPC_SERVICE_NAME': '0', 19:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:29 INFO - Downloading/unpacking blobuploader==1.2.4 19:45:29 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 19:45:29 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 19:45:29 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 19:45:29 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 19:45:29 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 19:45:29 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 19:45:31 INFO - Downloading blobuploader-1.2.4.tar.gz 19:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:45:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:45:31 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 19:45:31 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 19:45:31 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 19:45:31 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 19:45:31 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 19:45:31 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 19:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:45:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:45:32 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 19:45:32 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 19:45:32 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 19:45:32 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 19:45:32 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 19:45:32 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 19:45:32 INFO - Downloading docopt-0.6.1.tar.gz 19:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:45:32 INFO - Installing collected packages: blobuploader, requests, docopt 19:45:32 INFO - Running setup.py install for blobuploader 19:45:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:45:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:45:33 INFO - Running setup.py install for requests 19:45:33 INFO - Running setup.py install for docopt 19:45:33 INFO - Successfully installed blobuploader requests docopt 19:45:33 INFO - Cleaning up... 19:45:33 INFO - Return code: 0 19:45:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:45:33 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')]} 19:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:33 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')]} 19:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:33 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 0x103ddd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4825246f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, '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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:45:33 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 19:45:33 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 19:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:33 INFO - 'HOME': '/Users/cltbld', 19:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:33 INFO - 'LOGNAME': 'cltbld', 19:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:33 INFO - 'MOZ_NO_REMOTE': '1', 19:45:33 INFO - 'NO_EM_RESTART': '1', 19:45:33 INFO - 'PAGER': '/bin/cat', 19:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:33 INFO - 'PWD': '/builds/slave/test', 19:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:33 INFO - 'SHELL': '/bin/bash', 19:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:45:33 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:33 INFO - 'USER': 'cltbld', 19:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:33 INFO - 'XPC_FLAGS': '0x0', 19:45:33 INFO - 'XPC_SERVICE_NAME': '0', 19:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:45:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-_PbLPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:45:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-NxAq5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:45:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-nvcrMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:45:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-qWwh9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:45:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-HmdMls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:45:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-C23FRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:45:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-KUxwNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:45:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-JfCu9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:45:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Y2Da_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:45:34 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-fIkTJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:45:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Anp_Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:45:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-FsrTk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:45:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Qc2P3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:45:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-P7ZIF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:45:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-3p7Pdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:45:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-7yxkG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:45:35 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-0W8TG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:45:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:45:35 INFO - Running setup.py install for manifestparser 19:45:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:45:35 INFO - Running setup.py install for mozcrash 19:45:36 INFO - Running setup.py install for mozdebug 19:45:36 INFO - Running setup.py install for mozdevice 19:45:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:45:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:45:36 INFO - Running setup.py install for mozfile 19:45:36 INFO - Running setup.py install for mozhttpd 19:45:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:45:36 INFO - Running setup.py install for mozinfo 19:45:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:45:36 INFO - Running setup.py install for mozInstall 19:45:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:45:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:45:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:45:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:45:36 INFO - Running setup.py install for mozleak 19:45:37 INFO - Running setup.py install for mozlog 19:45:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:45:37 INFO - Running setup.py install for moznetwork 19:45:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:45:37 INFO - Running setup.py install for mozprocess 19:45:37 INFO - Running setup.py install for mozprofile 19:45:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:45:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:45:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:45:37 INFO - Running setup.py install for mozrunner 19:45:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:45:37 INFO - Running setup.py install for mozscreenshot 19:45:38 INFO - Running setup.py install for moztest 19:45:38 INFO - Running setup.py install for mozversion 19:45:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:45:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:45:38 INFO - Cleaning up... 19:45:38 INFO - Return code: 0 19:45:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:45:38 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')]} 19:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:38 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')]} 19:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:38 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 0x103ddd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4825246f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, '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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:45:38 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 19:45:38 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 19:45:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:45:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:38 INFO - 'HOME': '/Users/cltbld', 19:45:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:38 INFO - 'LOGNAME': 'cltbld', 19:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:38 INFO - 'MOZ_NO_REMOTE': '1', 19:45:38 INFO - 'NO_EM_RESTART': '1', 19:45:38 INFO - 'PAGER': '/bin/cat', 19:45:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:38 INFO - 'PWD': '/builds/slave/test', 19:45:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:38 INFO - 'SHELL': '/bin/bash', 19:45:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:45:38 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:45:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:38 INFO - 'USER': 'cltbld', 19:45:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:38 INFO - 'XPC_FLAGS': '0x0', 19:45:38 INFO - 'XPC_SERVICE_NAME': '0', 19:45:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:45:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-5obxEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:45:38 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)) 19:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:45:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-LhiDW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:45:38 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)) 19:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:45:38 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-fmhVCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:45:38 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)) 19:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:45:39 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-G5U1vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:45:39 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)) 19:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:45:39 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-xhSOps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:45:39 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)) 19:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:45:39 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-9fK3KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:45:39 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)) 19:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:45:39 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-ai8uuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:45:39 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)) 19:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:45:39 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-QcYW2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:45:39 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)) 19:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:45:39 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-4Q03aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:45:39 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)) 19:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:45:39 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-J7ihQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:45:39 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)) 19:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:45:39 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-TwBP2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:45:39 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)) 19:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:45:39 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-a7GTJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:45:39 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)) 19:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:45:39 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-490jal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:45:40 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)) 19:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:45:40 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-lAlnBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:45:40 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)) 19:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:45:40 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-as6S7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:45:40 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)) 19:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:45:40 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-2SmIqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:45:40 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)) 19:45:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:45:40 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-MmvrF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:45:40 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)) 19:45:40 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)) 19:45:40 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)) 19:45:40 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)) 19:45:40 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)) 19:45:40 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)) 19:45:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:45:40 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 19:45:40 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 19:45:40 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 19:45:40 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 19:45:40 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 19:45:40 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 19:45:42 INFO - Downloading blessings-1.6.tar.gz 19:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:45:43 INFO - Installing collected packages: blessings 19:45:43 INFO - Running setup.py install for blessings 19:45:43 INFO - Successfully installed blessings 19:45:43 INFO - Cleaning up... 19:45:43 INFO - Return code: 0 19:45:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:45:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:45:43 INFO - Reading from file tmpfile_stdout 19:45:43 INFO - Current package versions: 19:45:43 INFO - blessings == 1.6 19:45:43 INFO - blobuploader == 1.2.4 19:45:43 INFO - docopt == 0.6.1 19:45:43 INFO - functools32 == 3.2.3-2 19:45:43 INFO - jsonschema == 2.5.1 19:45:43 INFO - manifestparser == 1.1 19:45:43 INFO - mozInstall == 1.12 19:45:43 INFO - mozcrash == 0.17 19:45:43 INFO - mozdebug == 0.1 19:45:43 INFO - mozdevice == 0.48 19:45:43 INFO - mozfile == 1.2 19:45:43 INFO - mozhttpd == 0.7 19:45:43 INFO - mozinfo == 0.9 19:45:43 INFO - mozleak == 0.1 19:45:43 INFO - mozlog == 3.4 19:45:43 INFO - moznetwork == 0.27 19:45:43 INFO - mozprocess == 0.23 19:45:43 INFO - mozprofile == 0.28 19:45:43 INFO - mozrunner == 6.12 19:45:43 INFO - mozscreenshot == 0.1 19:45:43 INFO - mozsystemmonitor == 0.3 19:45:43 INFO - moztest == 0.7 19:45:43 INFO - mozversion == 1.4 19:45:43 INFO - psutil == 3.1.1 19:45:43 INFO - requests == 1.2.3 19:45:43 INFO - wsgiref == 0.1.2 19:45:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:45: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')]} 19:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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')]} 19:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:44 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 0x103ddd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4825246f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, '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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:45:44 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 19:45:44 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 19:45:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:45:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:44 INFO - 'HOME': '/Users/cltbld', 19:45:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:44 INFO - 'LOGNAME': 'cltbld', 19:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:44 INFO - 'MOZ_NO_REMOTE': '1', 19:45:44 INFO - 'NO_EM_RESTART': '1', 19:45:44 INFO - 'PAGER': '/bin/cat', 19:45:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:44 INFO - 'PWD': '/builds/slave/test', 19:45:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:44 INFO - 'SHELL': '/bin/bash', 19:45:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:45:44 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:45:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:44 INFO - 'USER': 'cltbld', 19:45:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:44 INFO - 'XPC_FLAGS': '0x0', 19:45:44 INFO - 'XPC_SERVICE_NAME': '0', 19:45:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:44 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)) 19:45:44 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)) 19:45:44 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)) 19:45:44 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)) 19:45:44 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)) 19:45:44 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)) 19:45:44 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)) 19:45:44 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)) 19:45:44 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)) 19:45:44 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)) 19:45:44 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)) 19:45:44 INFO - Cleaning up... 19:45:44 INFO - Return code: 0 19:45:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:45: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')]} 19:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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')]} 19:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:45 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 0x103ddd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d53570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4825246f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, '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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 19:45:45 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 19:45:45 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 19:45:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:45:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:45 INFO - 'HOME': '/Users/cltbld', 19:45:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:45 INFO - 'LOGNAME': 'cltbld', 19:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:45 INFO - 'MOZ_NO_REMOTE': '1', 19:45:45 INFO - 'NO_EM_RESTART': '1', 19:45:45 INFO - 'PAGER': '/bin/cat', 19:45:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:45 INFO - 'PWD': '/builds/slave/test', 19:45:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:45 INFO - 'SHELL': '/bin/bash', 19:45:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:45:45 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:45:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:45 INFO - 'USER': 'cltbld', 19:45:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:45 INFO - 'XPC_FLAGS': '0x0', 19:45:45 INFO - 'XPC_SERVICE_NAME': '0', 19:45:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:45:45 INFO - Cleaning up... 19:45:45 INFO - Return code: 0 19:45:45 INFO - Running post-action listener: _resource_record_post_action 19:45:45 INFO - Running post-action listener: _start_resource_monitoring 19:45:45 INFO - Starting resource monitoring. 19:45:45 INFO - [mozharness: 2016-10-11 02:45:45.369325Z] Finished create-virtualenv step (success) 19:45:45 INFO - [mozharness: 2016-10-11 02:45:45.370378Z] Running install step. 19:45:45 INFO - Running pre-action listener: _resource_record_pre_action 19:45:45 INFO - Running main action method: install 19:45:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:45:45 INFO - Reading from file tmpfile_stdout 19:45:45 INFO - Detecting whether we're running mozinstall >=1.0... 19:45:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:45:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:45:45 INFO - Reading from file tmpfile_stdout 19:45:45 INFO - Output received: 19:45:45 INFO - Usage: mozinstall [options] installer 19:45:45 INFO - Options: 19:45:45 INFO - -h, --help show this help message and exit 19:45:45 INFO - -d DEST, --destination=DEST 19:45:45 INFO - Directory to install application into. [default: 19:45:45 INFO - "/builds/slave/test"] 19:45:45 INFO - --app=APP Application being installed. [default: firefox] 19:45:45 INFO - mkdir: /builds/slave/test/build/application 19:45:45 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'] 19:45:45 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 19:46:20 INFO - Reading from file tmpfile_stdout 19:46:20 INFO - Output received: 19:46:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:46:20 INFO - Running post-action listener: _resource_record_post_action 19:46:20 INFO - [mozharness: 2016-10-11 02:46:20.157210Z] Finished install step (success) 19:46:20 INFO - [mozharness: 2016-10-11 02:46:20.157363Z] Running run-tests step. 19:46:20 INFO - Running pre-action listener: _resource_record_pre_action 19:46:20 INFO - Running main action method: run_tests 19:46:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:46:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:46:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:46:20 INFO - 2016-10-10 19:46:20.171 screenresolution[1647:7610] starting screenresolution argv=screenresolution get 19:46:20 INFO - 2016-10-10 19:46:20.174 screenresolution[1647:7610] Display 0: 1600x1200x32@60 19:46:20 INFO - 2016-10-10 19:46:20.180 screenresolution[1648:7612] starting screenresolution argv=screenresolution list 19:46:20 INFO - Available Modes on Display 0 19:46:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:46:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:46:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:46:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:46:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:46:20 INFO - Intel Iris: 19:46:20 INFO - Chipset Model: Intel Iris 19:46:20 INFO - Type: GPU 19:46:20 INFO - Bus: Built-In 19:46:20 INFO - VRAM (Dynamic, Max): 1536 MB 19:46:20 INFO - Vendor: Intel (0x8086) 19:46:20 INFO - Device ID: 0x0a2e 19:46:20 INFO - Revision ID: 0x0009 19:46:20 INFO - Displays: 19:46:20 INFO - Display: 19:46:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:46:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:46:20 INFO - Display Serial Number: 1600x1200 60 19:46:20 INFO - Main Display: Yes 19:46:20 INFO - Mirror: Off 19:46:20 INFO - Online: Yes 19:46:20 INFO - Rotation: Supported 19:46:20 INFO - Return code: 0 19:46:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:46:20 INFO - Python 2.7.3 19:46:20 INFO - Return code: 0 19:46:20 INFO - grabbing minidump binary from tooltool 19:46:20 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')]} 19:46:20 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 0x103bf1d30>, '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 0x103a17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103be9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:46:20 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 19:46:20 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 19:46:20 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 19:46:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:46:20 INFO - Return code: 0 19:46:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:46:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:46:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:46:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:46:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:46:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 19:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0344 --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 19:46:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4FFR4Jn0Vn/Render', 19:46:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:20 INFO - 'HOME': '/Users/cltbld', 19:46:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:20 INFO - 'LOGNAME': 'cltbld', 19:46:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:46:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:20 INFO - 'MOZ_NO_REMOTE': '1', 19:46:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:46:20 INFO - 'NO_EM_RESTART': '1', 19:46:20 INFO - 'PAGER': '/bin/cat', 19:46:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:20 INFO - 'PWD': '/builds/slave/test', 19:46:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:46:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:20 INFO - 'SHELL': '/bin/bash', 19:46:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.naCl6XgXai/Listeners', 19:46:20 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 19:46:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:20 INFO - 'USER': 'cltbld', 19:46:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:20 INFO - 'XPC_FLAGS': '0x0', 19:46:20 INFO - 'XPC_SERVICE_NAME': '0', 19:46:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 19:46:20 INFO - mozversion application_buildid: 20161010185046 19:46:20 INFO - mozversion application_changeset: 2bd339bcc38f2ba3c1afcedd261cf7134b1619df 19:46:20 INFO - mozversion application_display_name: Nightly 19:46:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:46:20 INFO - mozversion application_name: Firefox 19:46:20 INFO - mozversion application_remotingname: firefox 19:46:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:46:20 INFO - mozversion application_vendor: Mozilla 19:46:20 INFO - mozversion application_version: 52.0a1 19:46:20 INFO - mozversion platform_buildid: 20161010185046 19:46:20 INFO - mozversion platform_changeset: 2bd339bcc38f2ba3c1afcedd261cf7134b1619df 19:46:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:46:20 INFO - mozversion platform_version: 52.0a1 19:46:20 INFO - using testdate: 1476153980 19:46:20 INFO - actual date: 1476153980 19:46:20 INFO - starting webserver on 'localhost:49279' 19:46:20 INFO - SUITE-START | Running 2 tests 19:46:20 INFO - TEST-START | dromaeo_css 19:46:20 INFO - operating with platform_type : mac_ 19:46:20 INFO - Initialising browser for dromaeo_css test... 19:46:20 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpUqFjPY/profile http://localhost:49279/getInfo.html) 19:46:23 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 19:46:23 INFO - PROCESS | 1658 | colorDepth:24 19:46:23 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 19:46:23 INFO - PROCESS | 1658 | __metrics 19:46:23 INFO - PROCESS | 1658 | 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" 19:46:23 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:46:23 INFO - TEST-INFO | 1658: exit 0 19:46:23 INFO - Browser initialized. 19:46:23 INFO - Running cycle 1/1 for dromaeo_css test... 19:46:23 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpUqFjPY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:46:35 INFO - PROCESS | 1660 | RSS: Main: 234807296 19:46:35 INFO - PROCESS | 1660 | 19:47:26 INFO - PROCESS | 1660 | 1476154046963 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] 19:49:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 19:49:42 INFO - PROCESS | 1660 | RSS: Main: 483880960 19:49:42 INFO - PROCESS | 1660 | 19:52:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 19:52:45 INFO - PROCESS | 1660 | RSS: Main: 373043200 19:52:45 INFO - PROCESS | 1660 | 19:55:48 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 19:55:48 INFO - PROCESS | 1660 | RSS: Main: 339615744 19:55:48 INFO - PROCESS | 1660 | 19:58:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 19:58:51 INFO - PROCESS | 1660 | RSS: Main: 331620352 19:58:51 INFO - PROCESS | 1660 | 20:01:55 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 20:01:55 INFO - PROCESS | 1660 | RSS: Main: 330964992 20:01:55 INFO - PROCESS | 1660 | 20:04:59 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 20:04:59 INFO - PROCESS | 1660 | RSS: Main: 421765120 20:04:59 INFO - PROCESS | 1660 | 20:04:59 INFO - PROCESS | 1660 | __start_tp_report 20:04:59 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 20:04:59 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 20:04:59 INFO - PROCESS | 1660 | |i|pagename|runs| 20:04:59 INFO - PROCESS | 1660 | |0;dojo.html;3214.164317277508;3222.5166225066246;3245.318483118545;3253.284277458958;3285.8192799396024;5502.202180683798;5543.6119471637;5558.305211848519;5574.136008918619;5580.218769372291;5569;5596.496315331619;5632.098864181732;5641.12562552804;5697.857553561163;4713.575778179963;4941.591646380783;5145.151050076733;5174.172132458807;5223.921641175385;5067.569256613192;5117.667351622151;5181.378234611833;5198.714070726109;5232.79068837248;5200.401953775307;5209;5226.973865130669;5236.554892834114;5239.371275446952;5039.949600504021;5073.46728593496;5138.409082955433;5159.25190847325;5198.246254293144;5049.722265275408;5056.266841308026;5113.463086375914;5115.923261151086;5122.359705036871;5445.646033007882;5456.863578410532;5497.862553436196;5568.888622227532;5576.470235327637;5901.704914754245;6055.636661800262;6057.848553786146;6076.787312444088;6085.117657939574;6046.244219472566;6071.058985857199;6129.695011270045;6157.846053848645;6226.564140510166;5662.320521537442;5663.235463212413;5668.26312579362;5674.092145256739;5678.0915053591225;6116.393687459516;6219.502439804804;6323.30443651198;6325.5255855811;6339.619622822645;5795.913061304083;5876.294844618673;5890.469857712741;5897.852553686106;5898.8820223595285;6025.4577088061405;6105.975331700744;6112.473085128069;6130.111133885651;6160.8767824643255;5994.490468310242;6006.039033754579;6032.336442991267;6032.577719559588;6047.03247480401;6080.726367313481;6089.695515224221;6112.327643959161;6117.480014198754;6119.724612392453;4752.904941901143;4800;4800.711957282504;4802.495737947535;4847.079054979543;4314.784260787011;4322.135572885435;4348.9997300621035;4350.499692535335;4402.911941761146;5545.417731138173;5615.241942337814;5623.437656234426;5627.943720562824;5631.549476041907;6041.516678665696;6089.360617135226;6092.299385570716;6183.783567575113;6188.907166392508;5578.8047418340975;5580.218769372291;5583.637063590853;5611.382747897728;5631.380548139701;5234.345706786652;5243.318368612056;5243.632945693841;5256.2904007959205;5256.868578285574;6135.538906165067;6317.7157027932935;6318.494520438354;6327.145835312174;6327.841803954754;4589.770511474346;5507.669539827623;5944.375840536854;5961.225040744849;6046.637201767908;6106.0274517605285;6136.846578835565;6156.168917196122;6192.287886893065;6197.5351848610635;5853.2976042875125;5857.58996870232;5863.794767183299;5877.529797616266;5886.911696324473;5952.4642782148085;5957.16599676037;5970.820875373745;6057.7879774207695;6078.7264573093435;5791.681457519877;5813.883722325614;5820.94179058204;5826.621269617462;5834;4650.255959046536;5794.62334948227;5820.243368362086;5822.272215973004;5851.356350801493;5655.264815573949;5696.971515142398;5709.200711900255;5711.914321285267;5717.828465146053;5797.681127538026;5835.533157347487;5839.386864379179;5841.1530328101335;5870.002099643157;5745.425457454221;5746.5402767779315;5748.511376532874;5762.394948530512;5821.476067153976 20:04:59 INFO - PROCESS | 1660 | |1;ext.html;489.8065264220633;520.7214140434868;531.6331731105539;542.2760614579536;555.4334578729695;30651.846740766294;32196.67803321966;32218.67781322186;32286.19284517885;32308.19229519263;41369.965750856245;41896.95257618561;42270.36594451086;44949.32576011362;44998.775006124924;8192.262696357328;8380.245777879989;9738.977407372231;9761.267904907125;9778.11996920277;9604.471754053524;9636.61453541861;9656.613735450574;9657.179139773129;9677;9616.615335386576;9666.081722236377;9680.564374603124;9722.2708296878;9743.415395076283;9593.952030239874;9687.854682179774;9725.465099419529;9726.31915765893;9737.707868763877;9579.089986451276;9654.855177172349;9670.371425857367;9681.757956051084;9684.467354295512;39838.402423963664;40101.398479022544;40175.59824401748;40206.59793402058;40283.59716402828;2959.2453924249394;3353.6478669739813;3493.807840568768;3586.946195807065;3734.972882457319;30887;31269.530957035662;31654.841725791222;32009.879654212225;32084.518732219036;3199.8720051197924;3252.2357246047395;3253.926204352582;3303.0421177858393;3376.96623033769;482974;483553;485755.57122214517;486156.13843861816;488588;31392.21519461986;57166.42833571694;57559.71220143873;57631.71184144053;57675;27641.585376219373;33647.32705345928;34222.48666270008;34886.30227395438;35039.82480087634;12173.756524869454;13918.09532380392;13942.83885997672;14302.427902883976;14503.057301275594;10358.792824143475;12266;12392.31842248685;12498.437570309357;12520.81218781719;7698.153203147649;7708.034451215017;7776.572288524186;7780.805479863048;7790.844183116306;3271.4275001874576;3312.950305745416;3320.66793320666;3328.334333133383;3364.6467120951947;900.9234215091791;924.3945215883607;932.664240873285;1022.7443139215196;1058.571278632155;29004.41991160207;29569.55645665317;29593.704062959096;30314.696853031186;30482.695173047985;908.8454962656365;1018.8115198688266;1043.2332235806675;1048.6958781953301;1204.1570900369777;13432.932835335761;14550;15662.216889155725;15731;15772.92113539448;628005;636827;640684;640813;641496;41123;41399;41460.79269603693;41475.963100922716;41491;1217.2635555488803;1261.5080118753694;1341.5572860956056;1374.4639590559689;1389.6525868532867;28790.568141478314;30836.22909427282;31106.53340199944;31248.687513124576;31704.524432133076;48253.75873120612;48925.5107448921;48984.26523602077;49116.50883491119;49146.508534914195;528009;529201;529740;529917;531041;22158.556828863653;25885.48229035371;26481.867590662696;27119;28011.299717507227;45988.31017534673;46872.29691554561;47211.34760283374;47738.52261477341;47906.76046619745;34745;38049.619503804606;38157.046073848374;38761.03097422474;40231.79884100678;37879.29543170619;38095.61904380921;38760.224795504495;39247.80376098101;39389;37228.06929826776;37364.06589835276;37554.061148471505;38087.42868856914;38206;32460.35079298448;33143;34717.47923781095;34827.303453930275;34939.951801446;21172.576548469253;25008.37479063038;25292.98828046931;25396.984120634967;25697.357566060997 20:04:59 INFO - PROCESS | 1660 | |2;jquery.html;326.9983650081749;369.50301844019793;375.29631940112307;378.32280218409056;402.50893909430505;15023.098614083163;15440.459583914566;16107.516774496784;20345.593088138266;20895.791042089575;19816.20735170595;20384.694229586567;20870.89564552179;21084.8945755271;21259.787402125974;4757.429108506984;5957.1532824824335;6269.749210031593;6284.5600807943465;6292.339304373044;4265.509466411371;4505.053938672866;6075.392460753934;6142.324344322121;6221.7822376216845;6547.410733034026;6871.072405225281;6893.3795958363735;6916.342947420012;6991;6556.049372840911;6787.287334829821;6835.624040677761;6844.486663500207;6955.826104347381;5790.826275211708;5896.796146844525;5951.047832346804;5970.34326224115;5970.492508136814;25006.49987000268;25308.367290817878;25511.617325740128;26020.21939341823;26504;2250.9887450562805;2252.6508391199227;2366.5503554324623;2371.679823223877;2483.136278780336;15139.54581362561;15239.85701072424;15562.299696513684;16045.518634440868;16054.277557509824;1770.1237887245768;1863.9720404193947;1868.5889104397147;1899.9905000475048;1957.38342422138;115351.42324288325;118583.4070829649;123003.3849830754;125861;139096.99999999898;11427.314361138358;11464.713382165513;11522.884771152181;11590.88409115898;11835.704107397383;14415.495457658932;14817.40730370773;14856.777148342784;14877.33052012662;14919.179445130405;8369.874451883226;8606.053334133241;8619.741407757778;8744.507815272616;8803.515806630568;8515.659373624985;8530.616122274389;8536.914630853613;8709.912900871037;8713.825723485495;4555.498895121534;4583.72497650142;4633.8841528961375;4673.158831410379;4675.111728771522;1547.3269127929161;1753.3074435597866;1823.1704574418607;1859.786853644159;1911.5890083632087;792.2394501278837;796.323125343465;898.1557336104041;929.6513807322254;930.9255259579218;20490.487737806376;20563.485912852;22348.329550113198;22350.66474002891;22420.103195872307;933.5099072986736;934.0566028311455;951.3483263964207;961.99038009619;994.164901482758;9550;11434.542618295342;11463.484143213574;11514.251573647685;11607.303561786151;519605;526521;539102;567868;578197;124846;126684;127019;127396;130586.34706826405;891.9108089191029;987.2102318145598;1062.559037999237;1066.6906597086913;1068.2468859454066;19072.33246836354;19513.90208056324;19651.508712282306;19760.60478790445;19807.306744263882;56398.8720225585;56682.716586416806;56873.43126568681;57118.42881571297;58275.70862145662;61958.69020654868;81418.96452588732;81931.18068819235;82707.58646206731;83432.58283708543;7004.719811207495;7554.811129721801;7589.975353327231;7640.770776876702;7762.340201082971;12926.612201633967;13099.869001309866;13224.867751322363;13726.65683357924;13968.30158492051;7794.688212471665;8817.911820881709;11378.601748938747;11388.316700997966;11601.01391381742;9866.654667086617;11174;11392.94303528477;11533.653990380302;11630.302181869114;10564.418956957134;11615.593454229062;11746.29522228669;11956.402179891145;12029.819552706891;8229.711960081368;8639.784005399664;8659.350548708746;10844.837327439936;11522.308661480003;10375.896241037795;11341.489632966372;11774.882251177378;11903.523859045541;12038.398080095785 20:04:59 INFO - PROCESS | 1660 | |3;mootools.html;1504.8043754311934;1526.8854835887307;1729.16135674198;1858.9814101858976;1913.1008426039757;8429.283510901572;8948.91051089489;8968.865467017991;8973.282137429007;8989.820203595924;7913.881291780628;8264.09094999551;8266.958665206666;8569.442986205891;8831.381803273773;2349.635806450003;2374.6556749271344;2383.511380167062;2386.653935179398;2388.10446082719;2354.058376649337;2361.9763802361927;2387.4270175158013;2393.5452264069772;2403.7115546134487;1975.7036444533292;2350.2714158610884;2377.5363804058215;2382.833201675883;2387.510560335127;2134.8505604607685;2177.074743234135;2353.6940197774265;2355.7644235576477;2356.4697942962866;2331.790138887491;2338.777816107467;2341.4965782356876;2345.7654234576576;2348.248560460653;8853.15894989975;8920.687775927812;8998.190162885307;9033.187013168847;9056.77358066047;5244.763985620656;5429.918551221735;5437.8368648940595;5440.319960004999;5440.537554307889;3495.1436897959907;3596.1369271374942;3739.4016957286976;3755.586885442599;3763.360228761117;949.6343907595557;1030.917526597878;1065.2915810985685;1082.9458527073693;1084.7125511739396;11781.352025638587;11900.404979750978;11901.880981190165;11908.285502869769;11910.225835320676;4524.298733696282;4614.146382919103;4807;4814.350062741485;4814.398200224972;10034.749131271778;10041.899581004096;10051.447170405552;10066.194704423628;10066.59733610662;5417.702026388586;5420.07858664028;5426.294581704353;5426.34883813937;5444.101723215705;4294.420253265832;4414.911701765946;4603.102395033004;4860.1737704590305;4993.900121997613;3860.96139038606;3864.439656249828;3972.900677483028;3981.402789581586;3990.102226998902;1257.251935098615;1265.3293754310046;1272.9045321600918;1277.559242061506;1287.6652070461748;789.057076793238;888.5690440136658;905.8097799462187;923.6490133749132;950.4819873169001;5319.494648008433;5607.074832652566;5799.217105690678;5978.1929439525975;6043.153958445821;425.15394365213;437.1693781814514;437.7395449707419;447.8611630394588;448.9820407183676;3897.9805100974313;3957.683385329167;3996.962308645392;4007.4389585457475;4016.9397459038137;8916.73249802507;9443.291753118543;10961.177911656658;10981.341119532854;10982.890171098186;10447.268691191695;10912.836307455394;10926.453677316262;10929.289596176222;10970.616028438966;8153.021637403431;8178.713745019015;8190.788487108447;8384;8388.328933685169;5683.488486036111;5772.942270577409;5810.506106980785;5867.6772777497645;5898.911516327173;10136.138428233682;10198.235132365251;10228.13060889803;10269.383836969806;10323.690289291333;9876.45679487635;10085.092341689284;10208.183345332503;10442.321249118782;10451.529681164213;6963.442924565921;7226.927730722626;7251;7476.775696729107;7661.770146895602;8195.631196596049;8480.406371553932;8514.659413623385;8587.527685977331;8597;6936.653167341714;7046.295370462913;7432.368248698921;7462.813429664302;7661.885071723817;7183.491466792032;7327.340539351484;7404.740834070782;7462;7476.850462990818;6871.9656401717675;7041.612711300928;7049.189343225389;7050.753223637148;7062;4984.8753781155765;5037.899242015066;5068.986202759536;5069.163588008085;5146.562542183956;4939.357883475125;5046.899062018812;5092.465291144376;5121.8719532012;5255.343082114736 20:04:59 INFO - PROCESS | 1660 | |4;prototype.html;298.8057762454405;299.3504096111437;309.0681594991102;314.3743949540414;315.46843568586945;5174.482551744828;5182.455842136578;5230.241614965832;5245.531251249647;5270.552003079733;4052.5947405259535;4345.760983145926;4583.679142460029;5038.244263360498;5164.793408263665;3385.542951701526;3951.170254246612;4012.9799351003203;4050.7164498485117;4052.939205911899;3472.982635086821;3828.0859570214893;3969.2656858481273;3995.6814251297;4038.1116154445976;3825.9043523911846;3953.644172024517;3973.324534829086;3975.8807235782974;4021.839126434954;3295.0609076413225;3985.6412922836794;3994.082840236703;4006.799660017017;4007.5190977082643;2887.6823549409546;3482.6343233960574;3495.6853883150384;3499.842507087187;3522.2779330237495;4712.905741885177;5066.164082926312;5079.288899554065;5111.821086262;5125.463430233164;4504.166729155117;4541.841830333277;4550.567696068868;4550.613197878184;4582.404287442644;5392.056390131711;5421.638584077858;5424.891502169974;5430.9185362219205;5447.400785913546;3102.813831170137;3512.2799826035603;3641.289948460051;3841.3469710149343;3846.4807251021034;4955.380577427822;5465.398806131322;5573.41479144692;5660.433956604306;5688.800891968761;3872.7482713624086;3884.553276373253;3890.5914878937306;3895.0846551060476;3907.27715372657;3791.9572117667863;3953.3872249801325;3964.5837187095517;3974.436488464924;3976.1451287973223;4333.739975601411;4558.2251017327135;4576.336431217454;4590.495045544987;4608.824749688875;4693.78877950493;5143.456962911187;5322.627416080914;5438;5458.905820634524;1261.7918642375842;1274.8725127487178;1349.1770020287618;1361.598328493097;1362.773503846546;851.2679095977454;853.3685073045901;900.9954950225207;917.202034230224;927.188709878856;4453.376527286183;5038.34501514808;5073.543381095719;5077.720725360141;5129.281900533928;4667.836625718083;5569.331680198402;5580.804671836466;5599.664020158803;5610.943890561042;4281.37920001598;4892.608591312686;4958.628102892298;5044.445111037856;5049.490604030164;2897.1453421240785;2908.75275601572;2919.715325256923;2926.244253447914;2946.8231906085703;4215.892740678792;4766.976165119152;5691.544676425876;5715.657060576379;5719.28508936383;5654.321481422256;5654.632448890891;5657.294472120768;5662.207290979266;5662.5753068520025;4837.95162048382;5495.6427832191575;5519.006578815852;5675.5459563234845;5683.573731970118;4802.927956080732;4813.518648135158;5095.878906640533;5250.711210883438;5630.183623374506;5568.192612071308;5576.637518561281;5585.916211256916;5595.328560572757;5656.660600363992;4822.903541929212;5819.592628516132;5819.621724587888;5849.970750146222;5886.764529418947;3016.7888247822443;3751.15598990225;3766.4726938228123;3806.410006449005;3822.1782316802023;4322.546132656026;4595.03620164985;5266.657667251617;5525;5591.552675785846;4987.276844857548;5444.237806707143;5462.3445186577865;5473.452654734495;5474.671519708831;4587.495375508624;5143.6399452039495;5452.827642056976;5528.281323428089;5536.446355364431;4833.73414462208;5218.24335471347;5247.4227834937365;5394.865128371665;5404.486573775485;3987.282289187974;5166.819161329336;5313.096773548429;5344.438833922538;5472.2338872557075;5111.79552817898;5356.276902618097;5364.7049412282695;5380.757865895966;5403.567714582745 20:04:59 INFO - PROCESS | 1660 | |5;yui.html;706.816227780777;729.5258082246539;731.4916133287361;773.8353777564766;793.4644115222223;14986.700265994687;15674;15695.058296502219;15720.84279157211;15993.600159996005;13819.37812798424;13860.514881979132;14168.574942751708;14209;14233.074850134733;681.7307163670347;701.6807352654555;703.7501686901153;707.1796715809662;840.6931470013462;698.8322802527408;847.1232274595794;874.5933141089392;876.1238761238761;881.5019513974584;907.5099446298991;911.6353458616541;919.8298314811781;921.4977837078775;924.523870206844;916.3951791817435;916.4272329793879;917.788908551037;918.1140199707314;919.3886065766258;527.8706716854357;544.1810075835881;685.6194811879404;686.8523267497512;687.9552829066095;12390.938045309806;12823.422945967453;14716.043457175356;14778.63053423673;15127.319270632848;14151.363188656433;14545.981781275315;15000.324985375684;15038.54884353471;15041.172735499653;9921.950390248076;11365.943170284096;11390.54437822486;11557.942210288895;11559.826602600968;3193.866177506998;3787.3182827091114;3830.0999265172663;3906.785126818024;3931.3120203964477;120439.79560204461;122018.38990805078;122192;123349;123649;11313.321200727984;11448.599299024661;11513.712157195969;11593.594224202112;11638.70903227426;24177.395565111012;24228.757712422652;24228.909699063584;24235.515289694107;24266.272011839672;7741.18717534662;7741.690332386642;7855.332296754726;7872.291493765589;7928.563928983961;4246.893827654333;4288.399624052635;4336.492654328985;4345.087531618396;4479.664025198123;3658.487811706363;3786.678132358725;3788.8484460621266;3792.412176112707;3792.4311353297226;642.7493277621732;658.0549605117257;658.2167221006987;672.794797586731;679.4700133895569;564.8616089058207;640.8526039011053;657.5364368120463;669.8024082895557;682.6962001909103;8002.679892804223;8654.87017694735;9170.532714765739;9266.332458024981;9460.24318054554;590.6603702870866;626.1765778001912;650.9739610415625;677.8305423644089;701.7438634898225;3945.4870866787132;4318.481782186158;4430.178162635625;4511.075229577928;4743.5967942724565;152997;155546.22226888794;158098.20950895172;160081;165152;138809.3059534696;142846;143624;146892;147981;104683.42974855383;116463.41768291274;116540.94369710553;117811.05472363088;122485;7207.954846547326;8284.710035148983;8508.560867594428;8976.86534701967;9002.47320692519;60940.695296523234;62047.19720092454;67066.66466667636;68796.31203688099;69208.65395672989;86119.56940215259;96084;100017.99982000378;100563;105467;12199.207051541622;12262.87737122653;13014.4143513544;13211.933940330622;13895.513657021957;14826.62933426673;15120;15624.531264062096;15664.451744188898;15672;13616.93191534036;13718.38267277955;14122.646933826736;14277.571672849832;14581.699183133156;13990;14057.648558786112;14296.070755400866;14437.205953672648;14726.779098313747;13259.403326850508;13486.730265394834;13717.314134293445;14248.358823852745;14365.64085897861;11123.388213648326;11387.715307117389;11530.365829879438;11554.653360399201;11824;9955.950220248853;10436.686899393031;10710.357378557312;11030.889691102986;11673.182877198515 20:04:59 INFO - PROCESS | 1660 | __end_tp_report 20:04:59 INFO - PROCESS | 1660 | __start_cc_report 20:04:59 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,3155 20:04:59 INFO - PROCESS | 1660 | __end_cc_report 20:04:59 INFO - PROCESS | 1660 | __startTimestamp1476155099722__endTimestamp 20:04:59 INFO - PROCESS | 1660 | 20:04:59 INFO - PROCESS | 1660 | ------- Summary: start ------- 20:04:59 INFO - PROCESS | 1660 | Number of tests: 6 20:04:59 INFO - PROCESS | 1660 | 20:04:59 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5579.34 Median:5717.83 stddev:622.81 (10.9%) stddev-sans-first:596.44 20:04:59 INFO - PROCESS | 1660 | Values: 3214.2 3222.5 3245.3 3253.3 3285.8 5502.2 5543.6 5558.3 5574.1 5580.2 5569.0 5596.5 5632.1 5641.1 5697.9 4713.6 4941.6 5145.2 5174.2 5223.9 5067.6 5117.7 5181.4 5198.7 5232.8 5200.4 5209.0 5227.0 5236.6 5239.4 5039.9 5073.5 5138.4 5159.3 5198.2 5049.7 5056.3 5113.5 5115.9 5122.4 5445.6 5456.9 5497.9 5568.9 5576.5 5901.7 6055.6 6057.8 6076.8 6085.1 6046.2 6071.1 6129.7 6157.8 6226.6 5662.3 5663.2 5668.3 5674.1 5678.1 6116.4 6219.5 6323.3 6325.5 6339.6 5795.9 5876.3 5890.5 5897.9 5898.9 6025.5 6106.0 6112.5 6130.1 6160.9 5994.5 6006.0 6032.3 6032.6 6047.0 6080.7 6089.7 6112.3 6117.5 6119.7 4752.9 4800.0 4800.7 4802.5 4847.1 4314.8 4322.1 4349.0 4350.5 4402.9 5545.4 5615.2 5623.4 5627.9 5631.5 6041.5 6089.4 6092.3 6183.8 6188.9 5578.8 5580.2 5583.6 5611.4 5631.4 5234.3 5243.3 5243.6 5256.3 5256.9 6135.5 6317.7 6318.5 6327.1 6327.8 4589.8 5507.7 5944.4 5961.2 6046.6 6106.0 6136.8 6156.2 6192.3 6197.5 5853.3 5857.6 5863.8 5877.5 5886.9 5952.5 5957.2 5970.8 6057.8 6078.7 5791.7 5813.9 5820.9 5826.6 5834.0 4650.3 5794.6 5820.2 5822.3 5851.4 5655.3 5697.0 5709.2 5711.9 5717.8 5797.7 5835.5 5839.4 5841.2 5870.0 5745.4 5746.5 5748.5 5762.4 5821.5 20:04:59 INFO - PROCESS | 1660 | 20:04:59 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:66436.27 Median:38181.52 stddev:148475.55 (388.9%) stddev-sans-first:148809.51 20:04:59 INFO - PROCESS | 1660 | Values: 489.8 520.7 531.6 542.3 555.4 30651.8 32196.7 32218.7 32286.2 32308.2 41370.0 41897.0 42270.4 44949.3 44998.8 8192.3 8380.2 9739.0 9761.3 9778.1 9604.5 9636.6 9656.6 9657.2 9677.0 9616.6 9666.1 9680.6 9722.3 9743.4 9594.0 9687.9 9725.5 9726.3 9737.7 9579.1 9654.9 9670.4 9681.8 9684.5 39838.4 40101.4 40175.6 40206.6 40283.6 2959.2 3353.6 3493.8 3586.9 3735.0 30887.0 31269.5 31654.8 32009.9 32084.5 3199.9 3252.2 3253.9 3303.0 3377.0 482974.0 483553.0 485755.6 486156.1 488588.0 31392.2 57166.4 57559.7 57631.7 57675.0 27641.6 33647.3 34222.5 34886.3 35039.8 12173.8 13918.1 13942.8 14302.4 14503.1 10358.8 12266.0 12392.3 12498.4 12520.8 7698.2 7708.0 7776.6 7780.8 7790.8 3271.4 3313.0 3320.7 3328.3 3364.6 900.9 924.4 932.7 1022.7 1058.6 29004.4 29569.6 29593.7 30314.7 30482.7 908.8 1018.8 1043.2 1048.7 1204.2 13432.9 14550.0 15662.2 15731.0 15772.9 628005.0 636827.0 640684.0 640813.0 641496.0 41123.0 41399.0 41460.8 41476.0 41491.0 1217.3 1261.5 1341.6 1374.5 1389.7 28790.6 30836.2 31106.5 31248.7 31704.5 48253.8 48925.5 48984.3 49116.5 49146.5 528009.0 529201.0 529740.0 529917.0 531041.0 22158.6 25885.5 26481.9 27119.0 28011.3 45988.3 46872.3 47211.3 47738.5 47906.8 34745.0 38049.6 38157.0 38761.0 40231.8 37879.3 38095.6 38760.2 39247.8 39389.0 37228.1 37364.1 37554.1 38087.4 38206.0 32460.4 33143.0 34717.5 34827.3 34940.0 21172.6 25008.4 25293.0 25397.0 25697.4 20:04:59 INFO - PROCESS | 1660 | 20:04:59 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:34119.94 Median:13744.82 stddev:91906.67 (668.7%) stddev-sans-first:92129.47 20:04:59 INFO - PROCESS | 1660 | Values: 327.0 369.5 375.3 378.3 402.5 15023.1 15440.5 16107.5 20345.6 20895.8 19816.2 20384.7 20870.9 21084.9 21259.8 4757.4 5957.2 6269.7 6284.6 6292.3 4265.5 4505.1 6075.4 6142.3 6221.8 6547.4 6871.1 6893.4 6916.3 6991.0 6556.0 6787.3 6835.6 6844.5 6955.8 5790.8 5896.8 5951.0 5970.3 5970.5 25006.5 25308.4 25511.6 26020.2 26504.0 2251.0 2252.7 2366.6 2371.7 2483.1 15139.5 15239.9 15562.3 16045.5 16054.3 1770.1 1864.0 1868.6 1900.0 1957.4 115351.4 118583.4 123003.4 125861.0 139097.0 11427.3 11464.7 11522.9 11590.9 11835.7 14415.5 14817.4 14856.8 14877.3 14919.2 8369.9 8606.1 8619.7 8744.5 8803.5 8515.7 8530.6 8536.9 8709.9 8713.8 4555.5 4583.7 4633.9 4673.2 4675.1 1547.3 1753.3 1823.2 1859.8 1911.6 792.2 796.3 898.2 929.7 930.9 20490.5 20563.5 22348.3 22350.7 22420.1 933.5 934.1 951.3 962.0 994.2 9550.0 11434.5 11463.5 11514.3 11607.3 519605.0 526521.0 539102.0 567868.0 578197.0 124846.0 126684.0 127019.0 127396.0 130586.3 891.9 987.2 1062.6 1066.7 1068.2 19072.3 19513.9 19651.5 19760.6 19807.3 56398.9 56682.7 56873.4 57118.4 58275.7 61958.7 81419.0 81931.2 82707.6 83432.6 7004.7 7554.8 7590.0 7640.8 7762.3 12926.6 13099.9 13224.9 13726.7 13968.3 7794.7 8817.9 11378.6 11388.3 11601.0 9866.7 11174.0 11392.9 11533.7 11630.3 10564.4 11615.6 11746.3 11956.4 12029.8 8229.7 8639.8 8659.4 10844.8 11522.3 10375.9 11341.5 11774.9 11903.5 12038.4 20:04:59 INFO - PROCESS | 1660 | 20:04:59 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5719.47 Median:4710.57 stddev:3242.77 (68.8%) stddev-sans-first:3236.40 20:04:59 INFO - PROCESS | 1660 | Values: 1504.8 1526.9 1729.2 1859.0 1913.1 8429.3 8948.9 8968.9 8973.3 8989.8 7913.9 8264.1 8267.0 8569.4 8831.4 2349.6 2374.7 2383.5 2386.7 2388.1 2354.1 2362.0 2387.4 2393.5 2403.7 1975.7 2350.3 2377.5 2382.8 2387.5 2134.9 2177.1 2353.7 2355.8 2356.5 2331.8 2338.8 2341.5 2345.8 2348.2 8853.2 8920.7 8998.2 9033.2 9056.8 5244.8 5429.9 5437.8 5440.3 5440.5 3495.1 3596.1 3739.4 3755.6 3763.4 949.6 1030.9 1065.3 1082.9 1084.7 11781.4 11900.4 11901.9 11908.3 11910.2 4524.3 4614.1 4807.0 4814.4 4814.4 10034.7 10041.9 10051.4 10066.2 10066.6 5417.7 5420.1 5426.3 5426.3 5444.1 4294.4 4414.9 4603.1 4860.2 4993.9 3861.0 3864.4 3972.9 3981.4 3990.1 1257.3 1265.3 1272.9 1277.6 1287.7 789.1 888.6 905.8 923.6 950.5 5319.5 5607.1 5799.2 5978.2 6043.2 425.2 437.2 437.7 447.9 449.0 3898.0 3957.7 3997.0 4007.4 4016.9 8916.7 9443.3 10961.2 10981.3 10982.9 10447.3 10912.8 10926.5 10929.3 10970.6 8153.0 8178.7 8190.8 8384.0 8388.3 5683.5 5772.9 5810.5 5867.7 5898.9 10136.1 10198.2 10228.1 10269.4 10323.7 9876.5 10085.1 10208.2 10442.3 10451.5 6963.4 7226.9 7251.0 7476.8 7661.8 8195.6 8480.4 8514.7 8587.5 8597.0 6936.7 7046.3 7432.4 7462.8 7661.9 7183.5 7327.3 7404.7 7462.0 7476.9 6872.0 7041.6 7049.2 7050.8 7062.0 4984.9 5037.9 5069.0 5069.2 5146.6 4939.4 5046.9 5092.5 5121.9 5255.3 20:04:59 INFO - PROCESS | 1660 | 20:04:59 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4406.68 Median:4957.00 stddev:1332.31 (26.9%) stddev-sans-first:1299.88 20:04:59 INFO - PROCESS | 1660 | Values: 298.8 299.4 309.1 314.4 315.5 5174.5 5182.5 5230.2 5245.5 5270.6 4052.6 4345.8 4583.7 5038.2 5164.8 3385.5 3951.2 4013.0 4050.7 4052.9 3473.0 3828.1 3969.3 3995.7 4038.1 3825.9 3953.6 3973.3 3975.9 4021.8 3295.1 3985.6 3994.1 4006.8 4007.5 2887.7 3482.6 3495.7 3499.8 3522.3 4712.9 5066.2 5079.3 5111.8 5125.5 4504.2 4541.8 4550.6 4550.6 4582.4 5392.1 5421.6 5424.9 5430.9 5447.4 3102.8 3512.3 3641.3 3841.3 3846.5 4955.4 5465.4 5573.4 5660.4 5688.8 3872.7 3884.6 3890.6 3895.1 3907.3 3792.0 3953.4 3964.6 3974.4 3976.1 4333.7 4558.2 4576.3 4590.5 4608.8 4693.8 5143.5 5322.6 5438.0 5458.9 1261.8 1274.9 1349.2 1361.6 1362.8 851.3 853.4 901.0 917.2 927.2 4453.4 5038.3 5073.5 5077.7 5129.3 4667.8 5569.3 5580.8 5599.7 5610.9 4281.4 4892.6 4958.6 5044.4 5049.5 2897.1 2908.8 2919.7 2926.2 2946.8 4215.9 4767.0 5691.5 5715.7 5719.3 5654.3 5654.6 5657.3 5662.2 5662.6 4838.0 5495.6 5519.0 5675.5 5683.6 4802.9 4813.5 5095.9 5250.7 5630.2 5568.2 5576.6 5585.9 5595.3 5656.7 4822.9 5819.6 5819.6 5850.0 5886.8 3016.8 3751.2 3766.5 3806.4 3822.2 4322.5 4595.0 5266.7 5525.0 5591.6 4987.3 5444.2 5462.3 5473.5 5474.7 4587.5 5143.6 5452.8 5528.3 5536.4 4833.7 5218.2 5247.4 5394.9 5404.5 3987.3 5166.8 5313.1 5344.4 5472.2 5111.8 5356.3 5364.7 5380.8 5403.6 20:04:59 INFO - PROCESS | 1660 | 20:04:59 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:26380.13 Median:13730.07 stddev:43030.73 (313.4%) stddev-sans-first:43108.26 20:04:59 INFO - PROCESS | 1660 | Values: 706.8 729.5 731.5 773.8 793.5 14986.7 15674.0 15695.1 15720.8 15993.6 13819.4 13860.5 14168.6 14209.0 14233.1 681.7 701.7 703.8 707.2 840.7 698.8 847.1 874.6 876.1 881.5 907.5 911.6 919.8 921.5 924.5 916.4 916.4 917.8 918.1 919.4 527.9 544.2 685.6 686.9 688.0 12390.9 12823.4 14716.0 14778.6 15127.3 14151.4 14546.0 15000.3 15038.5 15041.2 9922.0 11365.9 11390.5 11557.9 11559.8 3193.9 3787.3 3830.1 3906.8 3931.3 120439.8 122018.4 122192.0 123349.0 123649.0 11313.3 11448.6 11513.7 11593.6 11638.7 24177.4 24228.8 24228.9 24235.5 24266.3 7741.2 7741.7 7855.3 7872.3 7928.6 4246.9 4288.4 4336.5 4345.1 4479.7 3658.5 3786.7 3788.8 3792.4 3792.4 642.7 658.1 658.2 672.8 679.5 564.9 640.9 657.5 669.8 682.7 8002.7 8654.9 9170.5 9266.3 9460.2 590.7 626.2 651.0 677.8 701.7 3945.5 4318.5 4430.2 4511.1 4743.6 152997.0 155546.2 158098.2 160081.0 165152.0 138809.3 142846.0 143624.0 146892.0 147981.0 104683.4 116463.4 116540.9 117811.1 122485.0 7208.0 8284.7 8508.6 8976.9 9002.5 60940.7 62047.2 67066.7 68796.3 69208.7 86119.6 96084.0 100018.0 100563.0 105467.0 12199.2 12262.9 13014.4 13211.9 13895.5 14826.6 15120.0 15624.5 15664.5 15672.0 13616.9 13718.4 14122.6 14277.6 14581.7 13990.0 14057.6 14296.1 14437.2 14726.8 13259.4 13486.7 13717.3 14248.4 14365.6 11123.4 11387.7 11530.4 11554.7 11824.0 9956.0 10436.7 10710.4 11030.9 11673.2 20:04:59 INFO - PROCESS | 1660 | -------- Summary: end -------- 20:04:59 INFO - PROCESS | 1660 | 20:05:00 INFO - TEST-INFO | 1660: exit 0 20:05:00 INFO - TEST-OK | dromaeo_css | took 1119662ms 20:05:00 INFO - TEST-START | kraken 20:05:00 INFO - operating with platform_type : mac_ 20:05:00 INFO - Initialising browser for kraken test... 20:05:00 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpiYCMo_/profile http://localhost:49279/getInfo.html) 20:05:02 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 20:05:02 INFO - PROCESS | 1669 | colorDepth:24 20:05:02 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 20:05:02 INFO - PROCESS | 1669 | __metrics 20:05:02 INFO - PROCESS | 1669 | 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" 20:05:02 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:05:03 INFO - TEST-INFO | 1669: exit 0 20:05:03 INFO - Browser initialized. 20:05:03 INFO - Running cycle 1/1 for kraken test... 20:05:03 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpiYCMo_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:05:15 INFO - PROCESS | 1670 | RSS: Main: 234704896 20:05:15 INFO - PROCESS | 1670 | 20:05:18 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 20:05:19 INFO - PROCESS | 1670 | RSS: Main: 293126144 20:05:19 INFO - PROCESS | 1670 | 20:05:21 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 20:05:22 INFO - PROCESS | 1670 | RSS: Main: 293642240 20:05:22 INFO - PROCESS | 1670 | 20:05:25 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 20:05:26 INFO - PROCESS | 1670 | RSS: Main: 385978368 20:05:26 INFO - PROCESS | 1670 | 20:05:28 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 20:05:29 INFO - PROCESS | 1670 | RSS: Main: 283803648 20:05:29 INFO - PROCESS | 1670 | 20:05:31 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:05:31 INFO - PROCESS | 1670 | RSS: Main: 289140736 20:05:31 INFO - PROCESS | 1670 | 20:05:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 20:05:35 INFO - PROCESS | 1670 | RSS: Main: 327245824 20:05:35 INFO - PROCESS | 1670 | 20:05:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 20:05:38 INFO - PROCESS | 1670 | RSS: Main: 327114752 20:05:38 INFO - PROCESS | 1670 | 20:05:41 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 20:05:41 INFO - PROCESS | 1670 | RSS: Main: 324624384 20:05:41 INFO - PROCESS | 1670 | 20:05:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:05:44 INFO - PROCESS | 1670 | RSS: Main: 300412928 20:05:44 INFO - PROCESS | 1670 | 20:05:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:05:46 INFO - PROCESS | 1670 | RSS: Main: 303648768 20:05:46 INFO - PROCESS | 1670 | 20:05:48 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:05:49 INFO - PROCESS | 1670 | RSS: Main: 310640640 20:05:49 INFO - PROCESS | 1670 | 20:05:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:05:53 INFO - PROCESS | 1670 | RSS: Main: 324055040 20:05:53 INFO - PROCESS | 1670 | 20:05:56 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:05:57 INFO - PROCESS | 1670 | RSS: Main: 322428928 20:05:57 INFO - PROCESS | 1670 | 20:05:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 20:05:59 INFO - PROCESS | 1670 | RSS: Main: 366186496 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | __start_tp_report 20:05:59 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 20:05:59 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 20:05:59 INFO - PROCESS | 1670 | |i|pagename|runs| 20:05:59 INFO - PROCESS | 1670 | |0;ai-astar;111;113;114;113;113;113;112;113;113;113 20:05:59 INFO - PROCESS | 1670 | |1;audio-beat-detection;150;133;145;182;114;111;113;118;165;140 20:05:59 INFO - PROCESS | 1670 | |2;audio-dft;183;182;186;184;183;184;181;185;179;182 20:05:59 INFO - PROCESS | 1670 | |3;audio-fft;77;58;58;87;61;58;59;56;81;57 20:05:59 INFO - PROCESS | 1670 | |4;audio-oscillator;89;70;92;71;69;68;92;67;69;90 20:05:59 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;90;91;93;91;90;85;95;91;90;87 20:05:59 INFO - PROCESS | 1670 | |6;imaging-darkroom;94;94;94;93;94;94;94;94;94;94 20:05:59 INFO - PROCESS | 1670 | |7;imaging-desaturate;86;88;84;83;85;83;84;83;83;83 20:05:59 INFO - PROCESS | 1670 | |8;json-parse-financial;57;56;55;53;56;55;55;54;54;55 20:05:59 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;63;74;66;76;74;68;69;69;69;70 20:05:59 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;86;91;89;85;95;105;104;85;92;87 20:05:59 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;147;146;147;149;161;154;176;162;239;163 20:05:59 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;172;172;173;171;233;183;174;172;176;172 20:05:59 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;69;69;69;70;78;87;87;90;74;69 20:05:59 INFO - PROCESS | 1670 | __end_tp_report 20:05:59 INFO - PROCESS | 1670 | __start_cc_report 20:05:59 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,2029 20:05:59 INFO - PROCESS | 1670 | __end_cc_report 20:05:59 INFO - PROCESS | 1670 | __startTimestamp1476155159128__endTimestamp 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | ------- Summary: start ------- 20:05:59 INFO - PROCESS | 1670 | Number of tests: 14 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:0.79 (0.7%) stddev-sans-first:0.50 20:05:59 INFO - PROCESS | 1670 | Values: 111.0 113.0 114.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:142.50 stddev:24.06 (16.9%) stddev-sans-first:25.06 20:05:59 INFO - PROCESS | 1670 | Values: 150.0 133.0 145.0 182.0 114.0 111.0 113.0 118.0 165.0 140.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:2.02 (1.1%) stddev-sans-first:2.15 20:05:59 INFO - PROCESS | 1670 | Values: 183.0 182.0 186.0 184.0 183.0 184.0 181.0 185.0 179.0 182.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:65.20 Median:60.00 stddev:11.68 (19.5%) stddev-sans-first:11.58 20:05:59 INFO - PROCESS | 1670 | Values: 77.0 58.0 58.0 87.0 61.0 58.0 59.0 56.0 81.0 57.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:80.00 stddev:11.31 (14.1%) stddev-sans-first:11.24 20:05:59 INFO - PROCESS | 1670 | Values: 89.0 70.0 92.0 71.0 69.0 68.0 92.0 67.0 69.0 90.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:91.00 stddev:2.79 (3.1%) stddev-sans-first:2.96 20:05:59 INFO - PROCESS | 1670 | Values: 90.0 91.0 93.0 91.0 90.0 85.0 95.0 91.0 90.0 87.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:05:59 INFO - PROCESS | 1670 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:1.69 (2.0%) stddev-sans-first:1.66 20:05:59 INFO - PROCESS | 1670 | Values: 86.0 88.0 84.0 83.0 85.0 83.0 84.0 83.0 83.0 83.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.15 (2.1%) stddev-sans-first:0.97 20:05:59 INFO - PROCESS | 1670 | Values: 57.0 56.0 55.0 53.0 56.0 55.0 55.0 54.0 54.0 55.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.50 stddev:3.94 (5.7%) stddev-sans-first:3.32 20:05:59 INFO - PROCESS | 1670 | Values: 63.0 74.0 66.0 76.0 74.0 68.0 69.0 69.0 69.0 70.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:88.00 stddev:7.39 (8.4%) stddev-sans-first:7.52 20:05:59 INFO - PROCESS | 1670 | Values: 86.0 91.0 89.0 85.0 95.0 105.0 104.0 85.0 92.0 87.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:164.40 Median:161.50 stddev:27.91 (17.3%) stddev-sans-first:28.88 20:05:59 INFO - PROCESS | 1670 | Values: 147.0 146.0 147.0 149.0 161.0 154.0 176.0 162.0 239.0 163.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:173.50 stddev:19.02 (11.0%) stddev-sans-first:19.96 20:05:59 INFO - PROCESS | 1670 | Values: 172.0 172.0 173.0 171.0 233.0 183.0 174.0 172.0 176.0 172.0 20:05:59 INFO - PROCESS | 1670 | 20:05:59 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:76.00 stddev:8.68 (11.4%) stddev-sans-first:8.80 20:05:59 INFO - PROCESS | 1670 | Values: 69.0 69.0 69.0 70.0 78.0 87.0 87.0 90.0 74.0 69.0 20:05:59 INFO - PROCESS | 1670 | -------- Summary: end -------- 20:05:59 INFO - PROCESS | 1670 | 20:06:00 INFO - TEST-INFO | 1670: exit 0 20:06:00 INFO - TEST-OK | kraken | took 59674ms 20:06:00 INFO - SUITE-END | took 1179s 20:06:00 INFO - Completed test suite (00:19:39) 20:06:00 INFO - javascript benchmark 20:06:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.164317277508, 3222.5166225066246, 3245.318483118545, 3253.284277458958, 3285.8192799396024, 5502.202180683798, 5543.6119471637, 5558.305211848519, 5574.136008918619, 5580.218769372291, 5569.0, 5596.496315331619, 5632.098864181732, 5641.12562552804, 5697.857553561163, 4713.575778179963, 4941.591646380783, 5145.151050076733, 5174.172132458807, 5223.921641175385, 5067.569256613192, 5117.667351622151, 5181.378234611833, 5198.714070726109, 5232.79068837248, 5200.401953775307, 5209.0, 5226.973865130669, 5236.554892834114, 5239.371275446952, 5039.949600504021, 5073.46728593496, 5138.409082955433, 5159.25190847325, 5198.246254293144, 5049.722265275408, 5056.266841308026, 5113.463086375914, 5115.923261151086, 5122.359705036871, 5445.646033007882, 5456.863578410532, 5497.862553436196, 5568.888622227532, 5576.470235327637, 5901.704914754245, 6055.636661800262, 6057.848553786146, 6076.787312444088, 6085.117657939574, 6046.244219472566, 6071.058985857199, 6129.695011270045, 6157.846053848645, 6226.564140510166, 5662.320521537442, 5663.235463212413, 5668.26312579362, 5674.092145256739, 5678.0915053591225, 6116.393687459516, 6219.502439804804, 6323.30443651198, 6325.5255855811, 6339.619622822645, 5795.913061304083, 5876.294844618673, 5890.469857712741, 5897.852553686106, 5898.8820223595285, 6025.4577088061405, 6105.975331700744, 6112.473085128069, 6130.111133885651, 6160.8767824643255, 5994.490468310242, 6006.039033754579, 6032.336442991267, 6032.577719559588, 6047.03247480401, 6080.726367313481, 6089.695515224221, 6112.327643959161, 6117.480014198754, 6119.724612392453, 4752.904941901143, 4800.0, 4800.711957282504, 4802.495737947535, 4847.079054979543, 4314.784260787011, 4322.135572885435, 4348.9997300621035, 4350.499692535335, 4402.911941761146, 5545.417731138173, 5615.241942337814, 5623.437656234426, 5627.943720562824, 5631.549476041907, 6041.516678665696, 6089.360617135226, 6092.299385570716, 6183.783567575113, 6188.907166392508, 5578.8047418340975, 5580.218769372291, 5583.637063590853, 5611.382747897728, 5631.380548139701, 5234.345706786652, 5243.318368612056, 5243.632945693841, 5256.2904007959205, 5256.868578285574, 6135.538906165067, 6317.7157027932935, 6318.494520438354, 6327.145835312174, 6327.841803954754, 4589.770511474346, 5507.669539827623, 5944.375840536854, 5961.225040744849, 6046.637201767908, 6106.0274517605285, 6136.846578835565, 6156.168917196122, 6192.287886893065, 6197.5351848610635, 5853.2976042875125, 5857.58996870232, 5863.794767183299, 5877.529797616266, 5886.911696324473, 5952.4642782148085, 5957.16599676037, 5970.820875373745, 6057.7879774207695, 6078.7264573093435, 5791.681457519877, 5813.883722325614, 5820.94179058204, 5826.621269617462, 5834.0, 4650.255959046536, 5794.62334948227, 5820.243368362086, 5822.272215973004, 5851.356350801493, 5655.264815573949, 5696.971515142398, 5709.200711900255, 5711.914321285267, 5717.828465146053, 5797.681127538026, 5835.533157347487, 5839.386864379179, 5841.1530328101335, 5870.002099643157, 5745.425457454221, 5746.5402767779315, 5748.511376532874, 5762.394948530512, 5821.476067153976], "value": 5539.952737618926, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.8065264220633, 520.7214140434868, 531.6331731105539, 542.2760614579536, 555.4334578729695, 30651.846740766294, 32196.67803321966, 32218.67781322186, 32286.19284517885, 32308.19229519263, 41369.965750856245, 41896.95257618561, 42270.36594451086, 44949.32576011362, 44998.775006124924, 8192.262696357328, 8380.245777879989, 9738.977407372231, 9761.267904907125, 9778.11996920277, 9604.471754053524, 9636.61453541861, 9656.613735450574, 9657.179139773129, 9677.0, 9616.615335386576, 9666.081722236377, 9680.564374603124, 9722.2708296878, 9743.415395076283, 9593.952030239874, 9687.854682179774, 9725.465099419529, 9726.31915765893, 9737.707868763877, 9579.089986451276, 9654.855177172349, 9670.371425857367, 9681.757956051084, 9684.467354295512, 39838.402423963664, 40101.398479022544, 40175.59824401748, 40206.59793402058, 40283.59716402828, 2959.2453924249394, 3353.6478669739813, 3493.807840568768, 3586.946195807065, 3734.972882457319, 30887.0, 31269.530957035662, 31654.841725791222, 32009.879654212225, 32084.518732219036, 3199.8720051197924, 3252.2357246047395, 3253.926204352582, 3303.0421177858393, 3376.96623033769, 482974.0, 483553.0, 485755.57122214517, 486156.13843861816, 488588.0, 31392.21519461986, 57166.42833571694, 57559.71220143873, 57631.71184144053, 57675.0, 27641.585376219373, 33647.32705345928, 34222.48666270008, 34886.30227395438, 35039.82480087634, 12173.756524869454, 13918.09532380392, 13942.83885997672, 14302.427902883976, 14503.057301275594, 10358.792824143475, 12266.0, 12392.31842248685, 12498.437570309357, 12520.81218781719, 7698.153203147649, 7708.034451215017, 7776.572288524186, 7780.805479863048, 7790.844183116306, 3271.4275001874576, 3312.950305745416, 3320.66793320666, 3328.334333133383, 3364.6467120951947, 900.9234215091791, 924.3945215883607, 932.664240873285, 1022.7443139215196, 1058.571278632155, 29004.41991160207, 29569.55645665317, 29593.704062959096, 30314.696853031186, 30482.695173047985, 908.8454962656365, 1018.8115198688266, 1043.2332235806675, 1048.6958781953301, 1204.1570900369777, 13432.932835335761, 14550.0, 15662.216889155725, 15731.0, 15772.92113539448, 628005.0, 636827.0, 640684.0, 640813.0, 641496.0, 41123.0, 41399.0, 41460.79269603693, 41475.963100922716, 41491.0, 1217.2635555488803, 1261.5080118753694, 1341.5572860956056, 1374.4639590559689, 1389.6525868532867, 28790.568141478314, 30836.22909427282, 31106.53340199944, 31248.687513124576, 31704.524432133076, 48253.75873120612, 48925.5107448921, 48984.26523602077, 49116.50883491119, 49146.508534914195, 528009.0, 529201.0, 529740.0, 529917.0, 531041.0, 22158.556828863653, 25885.48229035371, 26481.867590662696, 27119.0, 28011.299717507227, 45988.31017534673, 46872.29691554561, 47211.34760283374, 47738.52261477341, 47906.76046619745, 34745.0, 38049.619503804606, 38157.046073848374, 38761.03097422474, 40231.79884100678, 37879.29543170619, 38095.61904380921, 38760.224795504495, 39247.80376098101, 39389.0, 37228.06929826776, 37364.06589835276, 37554.061148471505, 38087.42868856914, 38206.0, 32460.35079298448, 33143.0, 34717.47923781095, 34827.303453930275, 34939.951801446, 21172.576548469253, 25008.37479063038, 25292.98828046931, 25396.984120634967, 25697.357566060997], "value": 18153.720634667698, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.9983650081749, 369.50301844019793, 375.29631940112307, 378.32280218409056, 402.50893909430505, 15023.098614083163, 15440.459583914566, 16107.516774496784, 20345.593088138266, 20895.791042089575, 19816.20735170595, 20384.694229586567, 20870.89564552179, 21084.8945755271, 21259.787402125974, 4757.429108506984, 5957.1532824824335, 6269.749210031593, 6284.5600807943465, 6292.339304373044, 4265.509466411371, 4505.053938672866, 6075.392460753934, 6142.324344322121, 6221.7822376216845, 6547.410733034026, 6871.072405225281, 6893.3795958363735, 6916.342947420012, 6991.0, 6556.049372840911, 6787.287334829821, 6835.624040677761, 6844.486663500207, 6955.826104347381, 5790.826275211708, 5896.796146844525, 5951.047832346804, 5970.34326224115, 5970.492508136814, 25006.49987000268, 25308.367290817878, 25511.617325740128, 26020.21939341823, 26504.0, 2250.9887450562805, 2252.6508391199227, 2366.5503554324623, 2371.679823223877, 2483.136278780336, 15139.54581362561, 15239.85701072424, 15562.299696513684, 16045.518634440868, 16054.277557509824, 1770.1237887245768, 1863.9720404193947, 1868.5889104397147, 1899.9905000475048, 1957.38342422138, 115351.42324288325, 118583.4070829649, 123003.3849830754, 125861.0, 139096.99999999898, 11427.314361138358, 11464.713382165513, 11522.884771152181, 11590.88409115898, 11835.704107397383, 14415.495457658932, 14817.40730370773, 14856.777148342784, 14877.33052012662, 14919.179445130405, 8369.874451883226, 8606.053334133241, 8619.741407757778, 8744.507815272616, 8803.515806630568, 8515.659373624985, 8530.616122274389, 8536.914630853613, 8709.912900871037, 8713.825723485495, 4555.498895121534, 4583.72497650142, 4633.8841528961375, 4673.158831410379, 4675.111728771522, 1547.3269127929161, 1753.3074435597866, 1823.1704574418607, 1859.786853644159, 1911.5890083632087, 792.2394501278837, 796.323125343465, 898.1557336104041, 929.6513807322254, 930.9255259579218, 20490.487737806376, 20563.485912852, 22348.329550113198, 22350.66474002891, 22420.103195872307, 933.5099072986736, 934.0566028311455, 951.3483263964207, 961.99038009619, 994.164901482758, 9550.0, 11434.542618295342, 11463.484143213574, 11514.251573647685, 11607.303561786151, 519605.0, 526521.0, 539102.0, 567868.0, 578197.0, 124846.0, 126684.0, 127019.0, 127396.0, 130586.34706826405, 891.9108089191029, 987.2102318145598, 1062.559037999237, 1066.6906597086913, 1068.2468859454066, 19072.33246836354, 19513.90208056324, 19651.508712282306, 19760.60478790445, 19807.306744263882, 56398.8720225585, 56682.716586416806, 56873.43126568681, 57118.42881571297, 58275.70862145662, 61958.69020654868, 81418.96452588732, 81931.18068819235, 82707.58646206731, 83432.58283708543, 7004.719811207495, 7554.811129721801, 7589.975353327231, 7640.770776876702, 7762.340201082971, 12926.612201633967, 13099.869001309866, 13224.867751322363, 13726.65683357924, 13968.30158492051, 7794.688212471665, 8817.911820881709, 11378.601748938747, 11388.316700997966, 11601.01391381742, 9866.654667086617, 11174.0, 11392.94303528477, 11533.653990380302, 11630.302181869114, 10564.418956957134, 11615.593454229062, 11746.29522228669, 11956.402179891145, 12029.819552706891, 8229.711960081368, 8639.784005399664, 8659.350548708746, 10844.837327439936, 11522.308661480003, 10375.896241037795, 11341.489632966372, 11774.882251177378, 11903.523859045541, 12038.398080095785], "value": 9803.877452804112, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.8043754311934, 1526.8854835887307, 1729.16135674198, 1858.9814101858976, 1913.1008426039757, 8429.283510901572, 8948.91051089489, 8968.865467017991, 8973.282137429007, 8989.820203595924, 7913.881291780628, 8264.09094999551, 8266.958665206666, 8569.442986205891, 8831.381803273773, 2349.635806450003, 2374.6556749271344, 2383.511380167062, 2386.653935179398, 2388.10446082719, 2354.058376649337, 2361.9763802361927, 2387.4270175158013, 2393.5452264069772, 2403.7115546134487, 1975.7036444533292, 2350.2714158610884, 2377.5363804058215, 2382.833201675883, 2387.510560335127, 2134.8505604607685, 2177.074743234135, 2353.6940197774265, 2355.7644235576477, 2356.4697942962866, 2331.790138887491, 2338.777816107467, 2341.4965782356876, 2345.7654234576576, 2348.248560460653, 8853.15894989975, 8920.687775927812, 8998.190162885307, 9033.187013168847, 9056.77358066047, 5244.763985620656, 5429.918551221735, 5437.8368648940595, 5440.319960004999, 5440.537554307889, 3495.1436897959907, 3596.1369271374942, 3739.4016957286976, 3755.586885442599, 3763.360228761117, 949.6343907595557, 1030.917526597878, 1065.2915810985685, 1082.9458527073693, 1084.7125511739396, 11781.352025638587, 11900.404979750978, 11901.880981190165, 11908.285502869769, 11910.225835320676, 4524.298733696282, 4614.146382919103, 4807.0, 4814.350062741485, 4814.398200224972, 10034.749131271778, 10041.899581004096, 10051.447170405552, 10066.194704423628, 10066.59733610662, 5417.702026388586, 5420.07858664028, 5426.294581704353, 5426.34883813937, 5444.101723215705, 4294.420253265832, 4414.911701765946, 4603.102395033004, 4860.1737704590305, 4993.900121997613, 3860.96139038606, 3864.439656249828, 3972.900677483028, 3981.402789581586, 3990.102226998902, 1257.251935098615, 1265.3293754310046, 1272.9045321600918, 1277.559242061506, 1287.6652070461748, 789.057076793238, 888.5690440136658, 905.8097799462187, 923.6490133749132, 950.4819873169001, 5319.494648008433, 5607.074832652566, 5799.217105690678, 5978.1929439525975, 6043.153958445821, 425.15394365213, 437.1693781814514, 437.7395449707419, 447.8611630394588, 448.9820407183676, 3897.9805100974313, 3957.683385329167, 3996.962308645392, 4007.4389585457475, 4016.9397459038137, 8916.73249802507, 9443.291753118543, 10961.177911656658, 10981.341119532854, 10982.890171098186, 10447.268691191695, 10912.836307455394, 10926.453677316262, 10929.289596176222, 10970.616028438966, 8153.021637403431, 8178.713745019015, 8190.788487108447, 8384.0, 8388.328933685169, 5683.488486036111, 5772.942270577409, 5810.506106980785, 5867.6772777497645, 5898.911516327173, 10136.138428233682, 10198.235132365251, 10228.13060889803, 10269.383836969806, 10323.690289291333, 9876.45679487635, 10085.092341689284, 10208.183345332503, 10442.321249118782, 10451.529681164213, 6963.442924565921, 7226.927730722626, 7251.0, 7476.775696729107, 7661.770146895602, 8195.631196596049, 8480.406371553932, 8514.659413623385, 8587.527685977331, 8597.0, 6936.653167341714, 7046.295370462913, 7432.368248698921, 7462.813429664302, 7661.885071723817, 7183.491466792032, 7327.340539351484, 7404.740834070782, 7462.0, 7476.850462990818, 6871.9656401717675, 7041.612711300928, 7049.189343225389, 7050.753223637148, 7062.0, 4984.8753781155765, 5037.899242015066, 5068.986202759536, 5069.163588008085, 5146.562542183956, 4939.357883475125, 5046.899062018812, 5092.465291144376, 5121.8719532012, 5255.343082114736], "value": 4507.283799249609, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.8057762454405, 299.3504096111437, 309.0681594991102, 314.3743949540414, 315.46843568586945, 5174.482551744828, 5182.455842136578, 5230.241614965832, 5245.531251249647, 5270.552003079733, 4052.5947405259535, 4345.760983145926, 4583.679142460029, 5038.244263360498, 5164.793408263665, 3385.542951701526, 3951.170254246612, 4012.9799351003203, 4050.7164498485117, 4052.939205911899, 3472.982635086821, 3828.0859570214893, 3969.2656858481273, 3995.6814251297, 4038.1116154445976, 3825.9043523911846, 3953.644172024517, 3973.324534829086, 3975.8807235782974, 4021.839126434954, 3295.0609076413225, 3985.6412922836794, 3994.082840236703, 4006.799660017017, 4007.5190977082643, 2887.6823549409546, 3482.6343233960574, 3495.6853883150384, 3499.842507087187, 3522.2779330237495, 4712.905741885177, 5066.164082926312, 5079.288899554065, 5111.821086262, 5125.463430233164, 4504.166729155117, 4541.841830333277, 4550.567696068868, 4550.613197878184, 4582.404287442644, 5392.056390131711, 5421.638584077858, 5424.891502169974, 5430.9185362219205, 5447.400785913546, 3102.813831170137, 3512.2799826035603, 3641.289948460051, 3841.3469710149343, 3846.4807251021034, 4955.380577427822, 5465.398806131322, 5573.41479144692, 5660.433956604306, 5688.800891968761, 3872.7482713624086, 3884.553276373253, 3890.5914878937306, 3895.0846551060476, 3907.27715372657, 3791.9572117667863, 3953.3872249801325, 3964.5837187095517, 3974.436488464924, 3976.1451287973223, 4333.739975601411, 4558.2251017327135, 4576.336431217454, 4590.495045544987, 4608.824749688875, 4693.78877950493, 5143.456962911187, 5322.627416080914, 5438.0, 5458.905820634524, 1261.7918642375842, 1274.8725127487178, 1349.1770020287618, 1361.598328493097, 1362.773503846546, 851.2679095977454, 853.3685073045901, 900.9954950225207, 917.202034230224, 927.188709878856, 4453.376527286183, 5038.34501514808, 5073.543381095719, 5077.720725360141, 5129.281900533928, 4667.836625718083, 5569.331680198402, 5580.804671836466, 5599.664020158803, 5610.943890561042, 4281.37920001598, 4892.608591312686, 4958.628102892298, 5044.445111037856, 5049.490604030164, 2897.1453421240785, 2908.75275601572, 2919.715325256923, 2926.244253447914, 2946.8231906085703, 4215.892740678792, 4766.976165119152, 5691.544676425876, 5715.657060576379, 5719.28508936383, 5654.321481422256, 5654.632448890891, 5657.294472120768, 5662.207290979266, 5662.5753068520025, 4837.95162048382, 5495.6427832191575, 5519.006578815852, 5675.5459563234845, 5683.573731970118, 4802.927956080732, 4813.518648135158, 5095.878906640533, 5250.711210883438, 5630.183623374506, 5568.192612071308, 5576.637518561281, 5585.916211256916, 5595.328560572757, 5656.660600363992, 4822.903541929212, 5819.592628516132, 5819.621724587888, 5849.970750146222, 5886.764529418947, 3016.7888247822443, 3751.15598990225, 3766.4726938228123, 3806.410006449005, 3822.1782316802023, 4322.546132656026, 4595.03620164985, 5266.657667251617, 5525.0, 5591.552675785846, 4987.276844857548, 5444.237806707143, 5462.3445186577865, 5473.452654734495, 5474.671519708831, 4587.495375508624, 5143.6399452039495, 5452.827642056976, 5528.281323428089, 5536.446355364431, 4833.73414462208, 5218.24335471347, 5247.4227834937365, 5394.865128371665, 5404.486573775485, 3987.282289187974, 5166.819161329336, 5313.096773548429, 5344.438833922538, 5472.2338872557075, 5111.79552817898, 5356.276902618097, 5364.7049412282695, 5380.757865895966, 5403.567714582745], "value": 3988.861905273071, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.816227780777, 729.5258082246539, 731.4916133287361, 773.8353777564766, 793.4644115222223, 14986.700265994687, 15674.0, 15695.058296502219, 15720.84279157211, 15993.600159996005, 13819.37812798424, 13860.514881979132, 14168.574942751708, 14209.0, 14233.074850134733, 681.7307163670347, 701.6807352654555, 703.7501686901153, 707.1796715809662, 840.6931470013462, 698.8322802527408, 847.1232274595794, 874.5933141089392, 876.1238761238761, 881.5019513974584, 907.5099446298991, 911.6353458616541, 919.8298314811781, 921.4977837078775, 924.523870206844, 916.3951791817435, 916.4272329793879, 917.788908551037, 918.1140199707314, 919.3886065766258, 527.8706716854357, 544.1810075835881, 685.6194811879404, 686.8523267497512, 687.9552829066095, 12390.938045309806, 12823.422945967453, 14716.043457175356, 14778.63053423673, 15127.319270632848, 14151.363188656433, 14545.981781275315, 15000.324985375684, 15038.54884353471, 15041.172735499653, 9921.950390248076, 11365.943170284096, 11390.54437822486, 11557.942210288895, 11559.826602600968, 3193.866177506998, 3787.3182827091114, 3830.0999265172663, 3906.785126818024, 3931.3120203964477, 120439.79560204461, 122018.38990805078, 122192.0, 123349.0, 123649.0, 11313.321200727984, 11448.599299024661, 11513.712157195969, 11593.594224202112, 11638.70903227426, 24177.395565111012, 24228.757712422652, 24228.909699063584, 24235.515289694107, 24266.272011839672, 7741.18717534662, 7741.690332386642, 7855.332296754726, 7872.291493765589, 7928.563928983961, 4246.893827654333, 4288.399624052635, 4336.492654328985, 4345.087531618396, 4479.664025198123, 3658.487811706363, 3786.678132358725, 3788.8484460621266, 3792.412176112707, 3792.4311353297226, 642.7493277621732, 658.0549605117257, 658.2167221006987, 672.794797586731, 679.4700133895569, 564.8616089058207, 640.8526039011053, 657.5364368120463, 669.8024082895557, 682.6962001909103, 8002.679892804223, 8654.87017694735, 9170.532714765739, 9266.332458024981, 9460.24318054554, 590.6603702870866, 626.1765778001912, 650.9739610415625, 677.8305423644089, 701.7438634898225, 3945.4870866787132, 4318.481782186158, 4430.178162635625, 4511.075229577928, 4743.5967942724565, 152997.0, 155546.22226888794, 158098.20950895172, 160081.0, 165152.0, 138809.3059534696, 142846.0, 143624.0, 146892.0, 147981.0, 104683.42974855383, 116463.41768291274, 116540.94369710553, 117811.05472363088, 122485.0, 7207.954846547326, 8284.710035148983, 8508.560867594428, 8976.86534701967, 9002.47320692519, 60940.695296523234, 62047.19720092454, 67066.66466667636, 68796.31203688099, 69208.65395672989, 86119.56940215259, 96084.0, 100017.99982000378, 100563.0, 105467.0, 12199.207051541622, 12262.87737122653, 13014.4143513544, 13211.933940330622, 13895.513657021957, 14826.62933426673, 15120.0, 15624.531264062096, 15664.451744188898, 15672.0, 13616.93191534036, 13718.38267277955, 14122.646933826736, 14277.571672849832, 14581.699183133156, 13990.0, 14057.648558786112, 14296.070755400866, 14437.205953672648, 14726.779098313747, 13259.403326850508, 13486.730265394834, 13717.314134293445, 14248.358823852745, 14365.64085897861, 11123.388213648326, 11387.715307117389, 11530.365829879438, 11554.653360399201, 11824.0, 9955.950220248853, 10436.686899393031, 10710.357378557312, 11030.889691102986, 11673.182877198515], "value": 7901.436525204682, "unit": "score"}], "name": "dromaeo_css", "value": 7206.606235589991, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 114.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 145.0, 182.0, 114.0, 111.0, 113.0, 118.0, 165.0, 140.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 186.0, 184.0, 183.0, 184.0, 181.0, 185.0, 179.0, 182.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 58.0, 87.0, 61.0, 58.0, 59.0, 56.0, 81.0, 57.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 92.0, 71.0, 69.0, 68.0, 92.0, 67.0, 69.0, 90.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 93.0, 91.0, 90.0, 85.0, 95.0, 91.0, 90.0, 87.0], "value": 90.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 84.0, 83.0, 85.0, 83.0, 84.0, 83.0, 83.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 53.0, 56.0, 55.0, 55.0, 54.0, 54.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 74.0, 66.0, 76.0, 74.0, 68.0, 69.0, 69.0, 69.0, 70.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 89.0, 85.0, 95.0, 105.0, 104.0, 85.0, 92.0, 87.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 149.0, 161.0, 154.0, 176.0, 162.0, 239.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 173.0, 171.0, 233.0, 183.0, 174.0, 172.0, 176.0, 172.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 70.0, 78.0, 87.0, 87.0, 90.0, 74.0, 69.0], "value": 76.2, "unit": "score"}], "name": "kraken", "value": 1481.2, "alertThreshold": 2.0}]} 20:06:00 INFO - Return code: 0 20:06:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:06:00 INFO - # TBPL SUCCESS # 20:06:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:06:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:06:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:06:00 INFO - 2016-10-10 20:06:00.434 screenresolution[1674:10095] starting screenresolution argv=screenresolution get 20:06:00 INFO - 2016-10-10 20:06:00.437 screenresolution[1674:10095] Display 0: 1600x1200x32@60 20:06:00 INFO - 2016-10-10 20:06:00.443 screenresolution[1675:10098] starting screenresolution argv=screenresolution list 20:06:00 INFO - Available Modes on Display 0 20:06:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:06:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:06:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:06:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:06:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:06:00 INFO - Intel Iris: 20:06:00 INFO - Chipset Model: Intel Iris 20:06:00 INFO - Type: GPU 20:06:00 INFO - Bus: Built-In 20:06:00 INFO - VRAM (Dynamic, Max): 1536 MB 20:06:00 INFO - Vendor: Intel (0x8086) 20:06:00 INFO - Device ID: 0x0a2e 20:06:00 INFO - Revision ID: 0x0009 20:06:00 INFO - Displays: 20:06:00 INFO - Display: 20:06:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:06:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:06:00 INFO - Display Serial Number: 1600x1200 60 20:06:00 INFO - Main Display: Yes 20:06:00 INFO - Mirror: Off 20:06:00 INFO - Online: Yes 20:06:00 INFO - Rotation: Supported 20:06:00 INFO - Return code: 0 20:06:00 INFO - Running post-action listener: _resource_record_post_action 20:06:00 INFO - [mozharness: 2016-10-11 03:06:00.687233Z] Finished run-tests step (success) 20:06:00 INFO - Running post-run listener: _resource_record_post_run 20:06:00 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37446656; Write bytes: 706812928; Read time: 242; Write time: 1950 20:06:00 INFO - TinderboxPrint: CPU usage
53.6% 20:06:00 INFO - TinderboxPrint: I/O read bytes / time
37,446,656 / 242 20:06:00 INFO - TinderboxPrint: I/O write bytes / time
706,812,928 / 1,950 20:06:00 INFO - TinderboxPrint: CPU idle
2,256.2 (46.4%) 20:06:00 INFO - TinderboxPrint: CPU system
975.7 (20.1%) 20:06:00 INFO - TinderboxPrint: CPU user
1,625.8 (33.5%) 20:06:00 INFO - TinderboxPrint: Swap in / out
445,042,688 / 0 20:06:00 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391825920; Write bytes: 386825216; Read time: 29425; Write time: 783 20:06:00 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36488192; Write bytes: 295604224; Read time: 229; Write time: 1111 20:06:01 INFO - Running post-run listener: _upload_blobber_files 20:06:01 INFO - Blob upload gear active. 20:06:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:06:01 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 20:06:01 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:06:01 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:06:01 INFO - (blobuploader) - INFO - Open directory for files ... 20:06:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:06:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:02 INFO - (blobuploader) - INFO - Done attempting. 20:06:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:06:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:06:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:03 INFO - (blobuploader) - INFO - Done attempting. 20:06:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:06:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:06:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:05 INFO - (blobuploader) - INFO - Done attempting. 20:06:05 INFO - (blobuploader) - INFO - Iteration through files over. 20:06:05 INFO - Return code: 0 20:06:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:06:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:06:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a8bc09cbc3f1d41123b01db4c16104596d5ad8714a23207a69acb9ce7f16616a05349c281a8398445c660c89dcd577169245dfc9426cac61bf66d1f16ec8f674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/61d2183da3ee68ed73401ebdcecbe4402d9ad5bd8cb506e9a19e96f15d9288817133bd2f8230b317ae82ddd62837a9e6cb1661ac601b59ccd9e326f730e629c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb89a024a3cbddb9496719e39d9a3b9dd752d92f60b6c9b50ce1a61a03b8143eeaa9204d00031e280d66aaf5d45ae5be289c9482192ce95d28d0a526e207d5e6"} 20:06:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:06:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:06:05 INFO - Contents: 20:06:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a8bc09cbc3f1d41123b01db4c16104596d5ad8714a23207a69acb9ce7f16616a05349c281a8398445c660c89dcd577169245dfc9426cac61bf66d1f16ec8f674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/61d2183da3ee68ed73401ebdcecbe4402d9ad5bd8cb506e9a19e96f15d9288817133bd2f8230b317ae82ddd62837a9e6cb1661ac601b59ccd9e326f730e629c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb89a024a3cbddb9496719e39d9a3b9dd752d92f60b6c9b50ce1a61a03b8143eeaa9204d00031e280d66aaf5d45ae5be289c9482192ce95d28d0a526e207d5e6"} 20:06:05 INFO - Running post-run listener: copy_logs_to_upload_dir 20:06:05 INFO - Copying logs to upload dir... 20:06:05 INFO - mkdir: /builds/slave/test/build/upload/logs 20:06:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.654466 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-10 20:06:05.823548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 20:06:05.827509) ========= 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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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/Autoland/sha512/a8bc09cbc3f1d41123b01db4c16104596d5ad8714a23207a69acb9ce7f16616a05349c281a8398445c660c89dcd577169245dfc9426cac61bf66d1f16ec8f674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/61d2183da3ee68ed73401ebdcecbe4402d9ad5bd8cb506e9a19e96f15d9288817133bd2f8230b317ae82ddd62837a9e6cb1661ac601b59ccd9e326f730e629c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb89a024a3cbddb9496719e39d9a3b9dd752d92f60b6c9b50ce1a61a03b8143eeaa9204d00031e280d66aaf5d45ae5be289c9482192ce95d28d0a526e207d5e6"} build_url:https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/GJ4X_IcfRWuk4EhRF3EmOA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a8bc09cbc3f1d41123b01db4c16104596d5ad8714a23207a69acb9ce7f16616a05349c281a8398445c660c89dcd577169245dfc9426cac61bf66d1f16ec8f674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/61d2183da3ee68ed73401ebdcecbe4402d9ad5bd8cb506e9a19e96f15d9288817133bd2f8230b317ae82ddd62837a9e6cb1661ac601b59ccd9e326f730e629c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb89a024a3cbddb9496719e39d9a3b9dd752d92f60b6c9b50ce1a61a03b8143eeaa9204d00031e280d66aaf5d45ae5be289c9482192ce95d28d0a526e207d5e6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 20:06:05.864852) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:06:05.865204) ========= 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.4FFR4Jn0Vn/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.naCl6XgXai/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.005237 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:06:05.914254) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 20:06:05.914573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 20:06:05.914903) ========= ========= Total master_lag: 0.19 =========