builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0279 starttime: 1476333134.59 results: success (0) buildid: 20161012193423 builduid: ef529c356fae46a8b298c06237cd324e revision: 5dc333cf5a5721a4488708b2b3cfcef0458c9fbc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:14.590760) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:14.591210) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:14.591487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:14.620342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:14.620738) ========= 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.fhz2JKrU5j/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.2jrslD9fLS/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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-12 21:32:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.4M=0.001s 2016-10-12 21:32:14 (17.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134136 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:14.777259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:14.777589) ========= 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.fhz2JKrU5j/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.2jrslD9fLS/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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.031556 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:14.834222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 21:32:14.834600) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5dc333cf5a5721a4488708b2b3cfcef0458c9fbc --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 5dc333cf5a5721a4488708b2b3cfcef0458c9fbc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fhz2JKrU5j/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.2jrslD9fLS/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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-12 21:32:14,920 truncating revision to first 12 chars 2016-10-12 21:32:14,920 Setting DEBUG logging. 2016-10-12 21:32:14,920 attempt 1/10 2016-10-12 21:32:14,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5dc333cf5a57?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 21:32:15,980 unpacking tar archive at: autoland-5dc333cf5a57/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346991 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 21:32:16.212372) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:16.212789) ========= script_repo_revision: 5dc333cf5a5721a4488708b2b3cfcef0458c9fbc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:16.213201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:16.218544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 21:32:16.237334) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-12 21:32:16.237740) ========= /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.fhz2JKrU5j/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.2jrslD9fLS/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:32:16 INFO - MultiFileLogger online at 20161012 21:32:16 in /builds/slave/test 21:32:16 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 21:32:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:32:16 INFO - {'append_to_log': False, 21:32:16 INFO - 'base_work_dir': '/builds/slave/test', 21:32:16 INFO - 'blob_upload_branch': 'Autoland', 21:32:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:32:16 INFO - 'branch': 'Autoland', 21:32:16 INFO - 'buildbot_json_path': 'buildprops.json', 21:32:16 INFO - 'config_files': ('talos/mac_config.py',), 21:32:16 INFO - 'default_actions': ('clobber', 21:32:16 INFO - 'read-buildbot-config', 21:32:16 INFO - 'download-and-extract', 21:32:16 INFO - 'populate-webroot', 21:32:16 INFO - 'create-virtualenv', 21:32:16 INFO - 'install', 21:32:16 INFO - 'run-tests'), 21:32:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:32:16 INFO - 'download_minidump_stackwalk': True, 21:32:16 INFO - 'download_symbols': 'ondemand', 21:32:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:32:16 INFO - 'tooltool.py': '/tools/tooltool.py', 21:32:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:32:16 INFO - '/tools/misc-python/virtualenv.py')}, 21:32:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:32:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:32:16 INFO - 'installer_path': 'installer.exe', 21:32:16 INFO - 'log_level': 'info', 21:32:16 INFO - 'log_name': 'talos', 21:32:16 INFO - 'log_to_console': True, 21:32:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:32:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:32:16 INFO - 'opt_config_files': (), 21:32:16 INFO - 'pip_index': False, 21:32:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:32:16 INFO - 'cmd': ('bash', 21:32:16 INFO - '-c', 21:32:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:32:16 INFO - 'enabled': True, 21:32:16 INFO - 'halt_on_failure': False, 21:32:16 INFO - 'name': 'check_screen_resolution'},), 21:32:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:32:16 INFO - 'cmd': ('bash', 21:32:16 INFO - '-c', 21:32:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:32:16 INFO - 'enabled': True, 21:32:16 INFO - 'halt_on_failure': False, 21:32:16 INFO - 'name': 'check_screen_resolution'},), 21:32:16 INFO - 'run_cmd_checks_enabled': True, 21:32:16 INFO - 'sps_profile': False, 21:32:16 INFO - 'sps_profile_interval': 0, 21:32:16 INFO - 'suite': 'dromaeojs', 21:32:16 INFO - 'system_bits': '32', 21:32:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:32:16 INFO - 'title': 't-yosemite-r7-0279', 21:32:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:32:16 INFO - 'use_talos_json': True, 21:32:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:32:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:32:16 INFO - 'work_dir': 'build'} 21:32:16 INFO - [mozharness: 2016-10-13 04:32:16.437900Z] Running clobber step. 21:32:16 INFO - Running pre-action listener: _resource_record_pre_action 21:32:16 INFO - Running main action method: clobber 21:32:16 INFO - rmtree: /builds/slave/test/build 21:32:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:32:18 INFO - Running post-action listener: _resource_record_post_action 21:32:18 INFO - [mozharness: 2016-10-13 04:32:18.595637Z] Finished clobber step (success) 21:32:18 INFO - [mozharness: 2016-10-13 04:32:18.595847Z] Running read-buildbot-config step. 21:32:18 INFO - Running pre-action listener: _resource_record_pre_action 21:32:18 INFO - Running main action method: read_buildbot_config 21:32:18 INFO - Using buildbot properties: 21:32:18 INFO - { 21:32:18 INFO - "project": "", 21:32:18 INFO - "product": "firefox", 21:32:18 INFO - "script_repo_revision": "production", 21:32:18 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 21:32:18 INFO - "repository": "", 21:32:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 21:32:18 INFO - "buildid": "20161012193423", 21:32:18 INFO - "pgo_build": "False", 21:32:18 INFO - "basedir": "/builds/slave/test", 21:32:18 INFO - "buildnumber": 232, 21:32:18 INFO - "slavename": "t-yosemite-r7-0279", 21:32:18 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 21:32:18 INFO - "platform": "yosemite_r7", 21:32:18 INFO - "scheduler": "tests-autoland-macosx64-talos", 21:32:18 INFO - "branch": "autoland", 21:32:18 INFO - "repo_path": "integration/autoland", 21:32:18 INFO - "revision": "5dc333cf5a5721a4488708b2b3cfcef0458c9fbc", 21:32:18 INFO - "stage_platform": "macosx64", 21:32:18 INFO - "builduid": "ef529c356fae46a8b298c06237cd324e", 21:32:18 INFO - "slavebuilddir": "test" 21:32:18 INFO - } 21:32:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 21:32:18 INFO - Running post-action listener: _resource_record_post_action 21:32:18 INFO - [mozharness: 2016-10-13 04:32:18.601161Z] Finished read-buildbot-config step (success) 21:32:18 INFO - [mozharness: 2016-10-13 04:32:18.601352Z] Running download-and-extract step. 21:32:18 INFO - Running pre-action listener: _resource_record_pre_action 21:32:18 INFO - Running main action method: download_and_extract 21:32:18 INFO - mkdir: /builds/slave/test/build/tests 21:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:18 INFO - trying https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 21:32:18 INFO - Downloading https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/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 21:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/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 21:32:19 INFO - Downloaded 1199 bytes. 21:32:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:32:19 INFO - Using the following test package requirements: 21:32:19 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:32:19 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:32:19 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 21:32:19 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:32:19 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 21:32:19 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:32:19 INFO - u'jsshell-mac.zip'], 21:32:19 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:32:19 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 21:32:19 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:32:19 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:32:19 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 21:32:19 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:32:19 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 21:32:19 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:32:19 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 21:32:19 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:32:19 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 21:32:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:32:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:32:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:32:19 INFO - Fetch https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:32:20 INFO - Http code: 200 21:32:20 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 21:32:20 INFO - x-amz-cf-id: RD28W0QZrzZlqxTHPLB4gSOA1MlkaAi2_8DL26ymP7VZ391VKabqTQ== 21:32:20 INFO - x-amz-version-id: .qlpg7MYkv_QrTvGF49S43sVjZQ4jlgS 21:32:20 INFO - Expected file size: 16511051 21:32:20 INFO - Obtained file size: 16511051 21:32:27 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 21:32:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:32:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:32:27 INFO - Fetch https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:32:27 INFO - Http code: 200 21:32:27 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 21:32:27 INFO - x-amz-cf-id: q8pXTpN70X-qo2tbhDc8_JRE4mfOBy8t3mKkFh8NOIyhDdbRwYDCtA== 21:32:27 INFO - x-amz-version-id: .qlpg7MYkv_QrTvGF49S43sVjZQ4jlgS 21:32:28 INFO - Expected file size: 16511051 21:32:28 INFO - Obtained file size: 16511051 21:32:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 21:32:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:32:34 INFO - Fetch https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 21:32:35 INFO - Http code: 200 21:32:35 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 21:32:35 INFO - x-amz-cf-id: tCe1E0dWI2cCfSnDH9f-XfIHCOV7AjHPggDFK-nBuOZkeqMGQ_fHxA== 21:32:35 INFO - x-amz-version-id: GgJDrAs3i35ewdQZesk4NElaJQ.HLIp3 21:32:35 INFO - Expected file size: 14409006 21:32:35 INFO - Obtained file size: 14409006 21:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:36 INFO - trying https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:32:36 INFO - Downloading https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 21:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/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 21:32:39 INFO - Downloaded 111684972 bytes. 21:32:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:32:39 INFO - mkdir: /builds/slave/test/properties 21:32:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:32:39 INFO - Writing to file /builds/slave/test/properties/build_url 21:32:39 INFO - Contents: 21:32:39 INFO - build_url:https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:32:39 INFO - Running post-action listener: _resource_record_post_action 21:32:39 INFO - Running post-action listener: set_extra_try_arguments 21:32:39 INFO - [mozharness: 2016-10-13 04:32:39.908595Z] Finished download-and-extract step (success) 21:32:39 INFO - [mozharness: 2016-10-13 04:32:39.908747Z] Running populate-webroot step. 21:32:39 INFO - Running pre-action listener: _resource_record_pre_action 21:32:39 INFO - Running main action method: populate_webroot 21:32:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:32:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:32:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:32:39 INFO - '--tppagecycles', 21:32:39 INFO - '7'], 21:32:39 INFO - 'tests': ['tsvgm']}}, 21:32:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:32:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:32:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:32:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:32:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:39 INFO - 'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:32:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:32:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:39 INFO - 'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['damp', 'tps']}, 21:32:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:39 INFO - 'tests': ['damp', 'tps']}, 21:32:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['dromaeo_dom']}, 21:32:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:32:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['basic_compositor_video']}, 21:32:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:32:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['a11yr', 21:32:39 INFO - 'ts_paint', 21:32:39 INFO - 'tpaint', 21:32:39 INFO - 'sessionrestore', 21:32:39 INFO - 'sessionrestore_no_auto_restore', 21:32:39 INFO - 'tabpaint']}, 21:32:39 INFO - 'other-e10s': {'tests': ['a11yr', 21:32:39 INFO - 'ts_paint', 21:32:39 INFO - 'tpaint', 21:32:39 INFO - 'sessionrestore', 21:32:39 INFO - 'sessionrestore_no_auto_restore', 21:32:39 INFO - 'tabpaint']}, 21:32:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:32:39 INFO - 'ts_paint', 21:32:39 INFO - 'tpaint', 21:32:39 INFO - 'sessionrestore', 21:32:39 INFO - 'sessionrestore_no_auto_restore', 21:32:39 INFO - 'tabpaint']}, 21:32:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:32:39 INFO - 'ts_paint', 21:32:39 INFO - 'tpaint', 21:32:39 INFO - 'sessionrestore', 21:32:39 INFO - 'sessionrestore_no_auto_restore', 21:32:39 INFO - 'tabpaint']}, 21:32:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['a11yr', 21:32:39 INFO - 'ts_paint', 21:32:39 INFO - 'tpaint', 21:32:39 INFO - 'sessionrestore', 21:32:39 INFO - 'sessionrestore_no_auto_restore', 21:32:39 INFO - 'tabpaint']}, 21:32:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['a11yr', 21:32:39 INFO - 'ts_paint', 21:32:39 INFO - 'tpaint', 21:32:39 INFO - 'sessionrestore', 21:32:39 INFO - 'sessionrestore_no_auto_restore', 21:32:39 INFO - 'tabpaint']}, 21:32:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['tsvgx', 21:32:39 INFO - 'tsvgr_opacity', 21:32:39 INFO - 'tart', 21:32:39 INFO - 'tscrollx', 21:32:39 INFO - 'cart']}, 21:32:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:32:39 INFO - 'tsvgr_opacity', 21:32:39 INFO - 'tart', 21:32:39 INFO - 'tscrollx', 21:32:39 INFO - 'cart']}, 21:32:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:39 INFO - 'talos_options': ['--disable-e10s'], 21:32:39 INFO - 'tests': ['tp5o']}, 21:32:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:39 INFO - 'tests': ['tp5o']}, 21:32:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:39 INFO - 'talos_options': ['--disable-e10s', 21:32:39 INFO - '--xperf_path', 21:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:32:39 INFO - 'tests': ['tp5n']}, 21:32:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:32:39 INFO - 'talos_options': ['--xperf_path', 21:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:32:39 INFO - 'tests': ['tp5n']}}, 21:32:39 INFO - 'talos.zip': {'path': '', 21:32:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:32:39 INFO - Running post-action listener: _resource_record_post_action 21:32:39 INFO - [mozharness: 2016-10-13 04:32:39.927940Z] Finished populate-webroot step (success) 21:32:39 INFO - [mozharness: 2016-10-13 04:32:39.928037Z] Running create-virtualenv step. 21:32:39 INFO - Running pre-action listener: _resource_record_pre_action 21:32:39 INFO - Running main action method: create_virtualenv 21:32:39 INFO - Creating virtualenv /builds/slave/test/build/venv 21:32:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:32:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:32:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:32:40 INFO - Using real prefix '/tools/python27' 21:32:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:32:40 INFO - Installing distribute.............................................................................................................................................................................................done. 21:32:43 INFO - Installing pip.................done. 21:32:43 INFO - Return code: 0 21:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:32:43 INFO - Reading from file tmpfile_stdout 21:32:43 INFO - Output received: 21:32:43 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:32:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f05490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e7b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa9cb58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, '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.fhz2JKrU5j/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.2jrslD9fLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:43 INFO - 'HOME': '/Users/cltbld', 21:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:43 INFO - 'LOGNAME': 'cltbld', 21:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:43 INFO - 'MOZ_NO_REMOTE': '1', 21:32:43 INFO - 'NO_EM_RESTART': '1', 21:32:43 INFO - 'PAGER': '/bin/cat', 21:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:43 INFO - 'PWD': '/builds/slave/test', 21:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:43 INFO - 'SHELL': '/bin/bash', 21:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:32:43 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:43 INFO - 'USER': 'cltbld', 21:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:43 INFO - 'XPC_FLAGS': '0x0', 21:32:43 INFO - 'XPC_SERVICE_NAME': '0', 21:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:32:44 INFO - Cleaning up... 21:32:44 INFO - Return code: 0 21:32:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f05490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e7b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa9cb58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, '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.fhz2JKrU5j/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.2jrslD9fLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:32:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:44 INFO - 'HOME': '/Users/cltbld', 21:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:44 INFO - 'LOGNAME': 'cltbld', 21:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:44 INFO - 'MOZ_NO_REMOTE': '1', 21:32:44 INFO - 'NO_EM_RESTART': '1', 21:32:44 INFO - 'PAGER': '/bin/cat', 21:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:44 INFO - 'PWD': '/builds/slave/test', 21:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:44 INFO - 'SHELL': '/bin/bash', 21:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:32:44 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:44 INFO - 'USER': 'cltbld', 21:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:44 INFO - 'XPC_FLAGS': '0x0', 21:32:44 INFO - 'XPC_SERVICE_NAME': '0', 21:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:44 INFO - Downloading/unpacking psutil>=3.1.1 21:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:32:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:32:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:32:47 INFO - Installing collected packages: psutil 21:32:47 INFO - Running setup.py install for psutil 21:32:47 INFO - building 'psutil._psutil_osx' extension 21:32:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:32:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:32:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:32:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 21:32:48 INFO - building 'psutil._psutil_posix' extension 21:32:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 21:32:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:32:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:32:48 INFO - ^ 21:32:48 INFO - 1 warning generated. 21:32:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 21:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:32:48 INFO - Successfully installed psutil 21:32:48 INFO - Cleaning up... 21:32:49 INFO - Return code: 0 21:32:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:32:49 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')]} 21:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:49 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')]} 21:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:49 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 0x101f05490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e7b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa9cb58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, '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.fhz2JKrU5j/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.2jrslD9fLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:32:49 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 21:32:49 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 21:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:49 INFO - 'HOME': '/Users/cltbld', 21:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:49 INFO - 'LOGNAME': 'cltbld', 21:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:49 INFO - 'MOZ_NO_REMOTE': '1', 21:32:49 INFO - 'NO_EM_RESTART': '1', 21:32:49 INFO - 'PAGER': '/bin/cat', 21:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:49 INFO - 'PWD': '/builds/slave/test', 21:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:49 INFO - 'SHELL': '/bin/bash', 21:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:32:49 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:49 INFO - 'USER': 'cltbld', 21:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:49 INFO - 'XPC_FLAGS': '0x0', 21:32:49 INFO - 'XPC_SERVICE_NAME': '0', 21:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:32:49 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 21:32:49 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 21:32:49 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 21:32:49 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 21:32:49 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 21:32:49 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 21:32:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:32:51 INFO - Installing collected packages: mozsystemmonitor 21:32:51 INFO - Running setup.py install for mozsystemmonitor 21:32:51 INFO - Successfully installed mozsystemmonitor 21:32:51 INFO - Cleaning up... 21:32:52 INFO - Return code: 0 21:32:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:32:52 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')]} 21:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:52 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')]} 21:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:52 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 0x101f05490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e7b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa9cb58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, '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.fhz2JKrU5j/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.2jrslD9fLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:32:52 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 21:32:52 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 21:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:52 INFO - 'HOME': '/Users/cltbld', 21:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:52 INFO - 'LOGNAME': 'cltbld', 21:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:52 INFO - 'MOZ_NO_REMOTE': '1', 21:32:52 INFO - 'NO_EM_RESTART': '1', 21:32:52 INFO - 'PAGER': '/bin/cat', 21:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:52 INFO - 'PWD': '/builds/slave/test', 21:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:52 INFO - 'SHELL': '/bin/bash', 21:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:32:52 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:52 INFO - 'USER': 'cltbld', 21:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:52 INFO - 'XPC_FLAGS': '0x0', 21:32:52 INFO - 'XPC_SERVICE_NAME': '0', 21:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:52 INFO - Downloading/unpacking jsonschema==2.5.1 21:32:52 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 21:32:52 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 21:32:52 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 21:32:52 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 21:32:52 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 21:32:52 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 21:32:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:32:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:55 INFO - Downloading functools32-3.2.3-2.tar.gz 21:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:32:55 INFO - warning: no files found matching '*.txt' 21:32:55 INFO - no previously-included directories found matching 'build' 21:32:55 INFO - no previously-included directories found matching 'dist' 21:32:55 INFO - no previously-included directories found matching '.git*' 21:32:55 INFO - Installing collected packages: jsonschema, functools32 21:32:55 INFO - Running setup.py install for functools32 21:32:55 INFO - warning: no files found matching '*.txt' 21:32:55 INFO - no previously-included directories found matching 'build' 21:32:55 INFO - no previously-included directories found matching 'dist' 21:32:55 INFO - no previously-included directories found matching '.git*' 21:32:55 INFO - Successfully installed jsonschema functools32 21:32:55 INFO - Cleaning up... 21:32:55 INFO - Return code: 0 21:32:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f05490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e7b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa9cb58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, '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.fhz2JKrU5j/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.2jrslD9fLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:55 INFO - 'HOME': '/Users/cltbld', 21:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:55 INFO - 'LOGNAME': 'cltbld', 21:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:55 INFO - 'MOZ_NO_REMOTE': '1', 21:32:55 INFO - 'NO_EM_RESTART': '1', 21:32:55 INFO - 'PAGER': '/bin/cat', 21:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:55 INFO - 'PWD': '/builds/slave/test', 21:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:55 INFO - 'SHELL': '/bin/bash', 21:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:32:55 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:55 INFO - 'USER': 'cltbld', 21:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:55 INFO - 'XPC_FLAGS': '0x0', 21:32:55 INFO - 'XPC_SERVICE_NAME': '0', 21:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:32:55 INFO - Cleaning up... 21:32:55 INFO - Return code: 0 21:32:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f05490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e7b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa9cb58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, '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.fhz2JKrU5j/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.2jrslD9fLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:55 INFO - 'HOME': '/Users/cltbld', 21:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:55 INFO - 'LOGNAME': 'cltbld', 21:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:55 INFO - 'MOZ_NO_REMOTE': '1', 21:32:55 INFO - 'NO_EM_RESTART': '1', 21:32:55 INFO - 'PAGER': '/bin/cat', 21:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:55 INFO - 'PWD': '/builds/slave/test', 21:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:55 INFO - 'SHELL': '/bin/bash', 21:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:32:55 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:55 INFO - 'USER': 'cltbld', 21:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:55 INFO - 'XPC_FLAGS': '0x0', 21:32:55 INFO - 'XPC_SERVICE_NAME': '0', 21:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:32:56 INFO - Downloading/unpacking blobuploader==1.2.4 21:32:56 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 21:32:56 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 21:32:56 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 21:32:56 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 21:32:56 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 21:32:56 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 21:32:58 INFO - Downloading blobuploader-1.2.4.tar.gz 21:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:32:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:32:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:32:59 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 21:32:59 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 21:32:59 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 21:32:59 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 21:32:59 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 21:32:59 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 21:32:59 INFO - Downloading docopt-0.6.1.tar.gz 21:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:32:59 INFO - Installing collected packages: blobuploader, requests, docopt 21:32:59 INFO - Running setup.py install for blobuploader 21:32:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:32:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:32:59 INFO - Running setup.py install for requests 21:33:00 INFO - Running setup.py install for docopt 21:33:00 INFO - Successfully installed blobuploader requests docopt 21:33:00 INFO - Cleaning up... 21:33:00 INFO - Return code: 0 21:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f05490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e7b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa9cb58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, '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.fhz2JKrU5j/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.2jrslD9fLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:00 INFO - 'HOME': '/Users/cltbld', 21:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:00 INFO - 'LOGNAME': 'cltbld', 21:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:00 INFO - 'MOZ_NO_REMOTE': '1', 21:33:00 INFO - 'NO_EM_RESTART': '1', 21:33:00 INFO - 'PAGER': '/bin/cat', 21:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:00 INFO - 'PWD': '/builds/slave/test', 21:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:00 INFO - 'SHELL': '/bin/bash', 21:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:33:00 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:00 INFO - 'USER': 'cltbld', 21:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:00 INFO - 'XPC_FLAGS': '0x0', 21:33:00 INFO - 'XPC_SERVICE_NAME': '0', 21:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:33:00 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-7ZWqGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:33:00 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-t_LeZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:33:01 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-pkrQ3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:33:01 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-y1a396-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:33:01 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-X2W1Xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:33:01 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-Mtr2_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:33:01 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-PUV8Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:33:01 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-IaFcRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:33:01 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-4fKGJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:33:01 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-hrjTkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:33:01 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-owSIms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:33:02 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-lD8XqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:33:02 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-4n8Vpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:33:02 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-llg863-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:02 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-MLtTu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:33:02 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-3F0nWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:33:02 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-RSlgSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:33:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:33:02 INFO - Running setup.py install for manifestparser 21:33:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:33:02 INFO - Running setup.py install for mozcrash 21:33:02 INFO - Running setup.py install for mozdebug 21:33:03 INFO - Running setup.py install for mozdevice 21:33:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:33:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:33:03 INFO - Running setup.py install for mozfile 21:33:03 INFO - Running setup.py install for mozhttpd 21:33:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:33:03 INFO - Running setup.py install for mozinfo 21:33:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:33:03 INFO - Running setup.py install for mozInstall 21:33:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:33:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:33:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:33:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:33:03 INFO - Running setup.py install for mozleak 21:33:03 INFO - Running setup.py install for mozlog 21:33:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:33:04 INFO - Running setup.py install for moznetwork 21:33:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:33:04 INFO - Running setup.py install for mozprocess 21:33:04 INFO - Running setup.py install for mozprofile 21:33:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:33:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:33:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:33:04 INFO - Running setup.py install for mozrunner 21:33:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:33:04 INFO - Running setup.py install for mozscreenshot 21:33:04 INFO - Running setup.py install for moztest 21:33:05 INFO - Running setup.py install for mozversion 21:33:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:33:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:33:05 INFO - Cleaning up... 21:33:05 INFO - Return code: 0 21:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f05490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e7b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa9cb58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, '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.fhz2JKrU5j/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.2jrslD9fLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:05 INFO - 'HOME': '/Users/cltbld', 21:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:05 INFO - 'LOGNAME': 'cltbld', 21:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:05 INFO - 'MOZ_NO_REMOTE': '1', 21:33:05 INFO - 'NO_EM_RESTART': '1', 21:33:05 INFO - 'PAGER': '/bin/cat', 21:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:05 INFO - 'PWD': '/builds/slave/test', 21:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:05 INFO - 'SHELL': '/bin/bash', 21:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:33:05 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:05 INFO - 'USER': 'cltbld', 21:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:05 INFO - 'XPC_FLAGS': '0x0', 21:33:05 INFO - 'XPC_SERVICE_NAME': '0', 21:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:33:05 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-zHTJe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:33:05 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-LznGmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:33:05 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-2ruTCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:33:05 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-Ann4oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:33:05 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-szqO3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:33:06 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)) 21:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:33:06 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-x3YAni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:33:06 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-2i11q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:33:06 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-DVOIjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:33:06 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-lXO6CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:33:06 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-ZhK0w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:33:06 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-o775zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:33:06 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-rbS4q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:33:06 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-oZxeMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:33:06 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-oj9A5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:33:07 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)) 21:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:07 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-YnHXsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:33:07 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)) 21:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:33:07 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-MoZG6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:33:07 INFO - Running setup.py (path:/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/pip-uSZoTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:33:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:33:09 INFO - Downloading blessings-1.6.tar.gz 21:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:33:09 INFO - Installing collected packages: blessings 21:33:09 INFO - Running setup.py install for blessings 21:33:10 INFO - Successfully installed blessings 21:33:10 INFO - Cleaning up... 21:33:10 INFO - Return code: 0 21:33:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:33:10 INFO - Reading from file tmpfile_stdout 21:33:10 INFO - Current package versions: 21:33:10 INFO - blessings == 1.6 21:33:10 INFO - blobuploader == 1.2.4 21:33:10 INFO - docopt == 0.6.1 21:33:10 INFO - functools32 == 3.2.3-2 21:33:10 INFO - jsonschema == 2.5.1 21:33:10 INFO - manifestparser == 1.1 21:33:10 INFO - mozInstall == 1.12 21:33:10 INFO - mozcrash == 0.17 21:33:10 INFO - mozdebug == 0.1 21:33:10 INFO - mozdevice == 0.48 21:33:10 INFO - mozfile == 1.2 21:33:10 INFO - mozhttpd == 0.7 21:33:10 INFO - mozinfo == 0.9 21:33:10 INFO - mozleak == 0.1 21:33:10 INFO - mozlog == 3.4 21:33:10 INFO - moznetwork == 0.27 21:33:10 INFO - mozprocess == 0.23 21:33:10 INFO - mozprofile == 0.28 21:33:10 INFO - mozrunner == 6.12 21:33:10 INFO - mozscreenshot == 0.1 21:33:10 INFO - mozsystemmonitor == 0.3 21:33:10 INFO - moztest == 0.7 21:33:10 INFO - mozversion == 1.4 21:33:10 INFO - psutil == 3.1.1 21:33:10 INFO - requests == 1.2.3 21:33:10 INFO - wsgiref == 0.1.2 21:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:11 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 0x101f05490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e7b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa9cb58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, '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.fhz2JKrU5j/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.2jrslD9fLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:33:11 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 21:33:11 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 21:33:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:33:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:11 INFO - 'HOME': '/Users/cltbld', 21:33:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:11 INFO - 'LOGNAME': 'cltbld', 21:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:11 INFO - 'MOZ_NO_REMOTE': '1', 21:33:11 INFO - 'NO_EM_RESTART': '1', 21:33:11 INFO - 'PAGER': '/bin/cat', 21:33:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:11 INFO - 'PWD': '/builds/slave/test', 21:33:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:11 INFO - 'SHELL': '/bin/bash', 21:33:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:33:11 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:33:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:11 INFO - 'USER': 'cltbld', 21:33:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:11 INFO - 'XPC_FLAGS': '0x0', 21:33:11 INFO - 'XPC_SERVICE_NAME': '0', 21:33:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:11 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)) 21:33:11 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)) 21:33:11 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)) 21:33:11 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)) 21:33:11 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)) 21:33:11 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)) 21:33:11 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)) 21:33:11 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)) 21:33:11 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)) 21:33:11 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)) 21:33:11 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)) 21:33:11 INFO - Cleaning up... 21:33:11 INFO - Return code: 0 21:33:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:33:11 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')]} 21:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:11 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')]} 21:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:33:11 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 0x101f05490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e7b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aa9cb58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, '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.fhz2JKrU5j/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.2jrslD9fLS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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 21:33:11 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 21:33:11 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 21:33:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:33:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:11 INFO - 'HOME': '/Users/cltbld', 21:33:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:11 INFO - 'LOGNAME': 'cltbld', 21:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:11 INFO - 'MOZ_NO_REMOTE': '1', 21:33:11 INFO - 'NO_EM_RESTART': '1', 21:33:11 INFO - 'PAGER': '/bin/cat', 21:33:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:11 INFO - 'PWD': '/builds/slave/test', 21:33:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:11 INFO - 'SHELL': '/bin/bash', 21:33:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:33:11 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:33:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:11 INFO - 'USER': 'cltbld', 21:33:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:11 INFO - 'XPC_FLAGS': '0x0', 21:33:11 INFO - 'XPC_SERVICE_NAME': '0', 21:33:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:33:12 INFO - Cleaning up... 21:33:12 INFO - Return code: 0 21:33:12 INFO - Running post-action listener: _resource_record_post_action 21:33:12 INFO - Running post-action listener: _start_resource_monitoring 21:33:12 INFO - Starting resource monitoring. 21:33:12 INFO - [mozharness: 2016-10-13 04:33:12.085501Z] Finished create-virtualenv step (success) 21:33:12 INFO - [mozharness: 2016-10-13 04:33:12.086447Z] Running install step. 21:33:12 INFO - Running pre-action listener: _resource_record_pre_action 21:33:12 INFO - Running main action method: install 21:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:33:12 INFO - Reading from file tmpfile_stdout 21:33:12 INFO - Detecting whether we're running mozinstall >=1.0... 21:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:33:12 INFO - Reading from file tmpfile_stdout 21:33:12 INFO - Output received: 21:33:12 INFO - Usage: mozinstall [options] installer 21:33:12 INFO - Options: 21:33:12 INFO - -h, --help show this help message and exit 21:33:12 INFO - -d DEST, --destination=DEST 21:33:12 INFO - Directory to install application into. [default: 21:33:12 INFO - "/builds/slave/test"] 21:33:12 INFO - --app=APP Application being installed. [default: firefox] 21:33:12 INFO - mkdir: /builds/slave/test/build/application 21:33:12 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'] 21:33:12 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 21:33:46 INFO - Reading from file tmpfile_stdout 21:33:46 INFO - Output received: 21:33:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:33:46 INFO - Running post-action listener: _resource_record_post_action 21:33:46 INFO - [mozharness: 2016-10-13 04:33:46.773587Z] Finished install step (success) 21:33:46 INFO - [mozharness: 2016-10-13 04:33:46.773707Z] Running run-tests step. 21:33:46 INFO - Running pre-action listener: _resource_record_pre_action 21:33:46 INFO - Running main action method: run_tests 21:33:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:33:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:33:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:33:46 INFO - 2016-10-12 21:33:46.786 screenresolution[1635:7630] starting screenresolution argv=screenresolution get 21:33:46 INFO - 2016-10-12 21:33:46.789 screenresolution[1635:7630] Display 0: 1600x1200x32@60 21:33:46 INFO - 2016-10-12 21:33:46.795 screenresolution[1636:7632] starting screenresolution argv=screenresolution list 21:33:46 INFO - Available Modes on Display 0 21:33:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:33:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:33:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:33:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:33:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:33:47 INFO - Intel Iris: 21:33:47 INFO - Chipset Model: Intel Iris 21:33:47 INFO - Type: GPU 21:33:47 INFO - Bus: Built-In 21:33:47 INFO - VRAM (Dynamic, Max): 1536 MB 21:33:47 INFO - Vendor: Intel (0x8086) 21:33:47 INFO - Device ID: 0x0a2e 21:33:47 INFO - Revision ID: 0x0009 21:33:47 INFO - Displays: 21:33:47 INFO - Display: 21:33:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:33:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:33:47 INFO - Display Serial Number: 1600x1200 60 21:33:47 INFO - Main Display: Yes 21:33:47 INFO - Mirror: Off 21:33:47 INFO - Online: Yes 21:33:47 INFO - Rotation: Supported 21:33:47 INFO - Return code: 0 21:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:33:47 INFO - Python 2.7.3 21:33:47 INFO - Return code: 0 21:33:47 INFO - grabbing minidump binary from tooltool 21:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:33:47 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 0x101d19d30>, '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 0x101b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d11b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:33:47 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 21:33:47 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 21:33:47 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 21:33:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:33:47 INFO - Return code: 0 21:33:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:33:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:33:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:33:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:33:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:33:47 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/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0279', '--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 21:33:47 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/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0279 --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 21:33:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fhz2JKrU5j/Render', 21:33:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:33:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:33:47 INFO - 'HOME': '/Users/cltbld', 21:33:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:33:47 INFO - 'LOGNAME': 'cltbld', 21:33:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:33:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:33:47 INFO - 'MOZ_NO_REMOTE': '1', 21:33:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:33:47 INFO - 'NO_EM_RESTART': '1', 21:33:47 INFO - 'PAGER': '/bin/cat', 21:33:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:33:47 INFO - 'PWD': '/builds/slave/test', 21:33:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:33:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:33:47 INFO - 'SHELL': '/bin/bash', 21:33:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2jrslD9fLS/Listeners', 21:33:47 INFO - 'TMPDIR': '/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/', 21:33:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:33:47 INFO - 'USER': 'cltbld', 21:33:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:33:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:33:47 INFO - 'XPC_FLAGS': '0x0', 21:33:47 INFO - 'XPC_SERVICE_NAME': '0', 21:33:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:33:47 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/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0279', '--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 21:33:47 INFO - mozversion application_buildid: 20161012193423 21:33:47 INFO - mozversion application_changeset: 5dc333cf5a5721a4488708b2b3cfcef0458c9fbc 21:33:47 INFO - mozversion application_display_name: Nightly 21:33:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:33:47 INFO - mozversion application_name: Firefox 21:33:47 INFO - mozversion application_remotingname: firefox 21:33:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:33:47 INFO - mozversion application_vendor: Mozilla 21:33:47 INFO - mozversion application_version: 52.0a1 21:33:47 INFO - mozversion platform_buildid: 20161012193423 21:33:47 INFO - mozversion platform_changeset: 5dc333cf5a5721a4488708b2b3cfcef0458c9fbc 21:33:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:33:47 INFO - mozversion platform_version: 52.0a1 21:33:47 INFO - using testdate: 1476333227 21:33:47 INFO - actual date: 1476333227 21:33:47 INFO - starting webserver on 'localhost:49276' 21:33:47 INFO - SUITE-START | Running 2 tests 21:33:47 INFO - TEST-START | dromaeo_css 21:33:47 INFO - operating with platform_type : mac_ 21:33:47 INFO - Initialising browser for dromaeo_css test... 21:33:47 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/tmpFbPV0L/profile http://localhost:49276/getInfo.html) 21:33:49 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 21:33:49 INFO - PROCESS | 1646 | colorDepth:24 21:33:49 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 21:33:49 INFO - PROCESS | 1646 | __metrics 21:33:49 INFO - PROCESS | 1646 | 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" 21:33:49 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:33:50 INFO - TEST-INFO | 1646: exit 0 21:33:50 INFO - Browser initialized. 21:33:50 INFO - Running cycle 1/1 for dromaeo_css test... 21:33:50 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/tmpFbPV0L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:34:02 INFO - PROCESS | 1648 | RSS: Main: 243077120 21:34:02 INFO - PROCESS | 1648 | 21:34:54 INFO - PROCESS | 1648 | 1476333294081 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] 21:37:06 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 21:37:07 INFO - PROCESS | 1648 | RSS: Main: 349081600 21:37:07 INFO - PROCESS | 1648 | 21:40:10 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 21:40:11 INFO - PROCESS | 1648 | RSS: Main: 396226560 21:40:11 INFO - PROCESS | 1648 | 21:43:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 21:43:14 INFO - PROCESS | 1648 | RSS: Main: 334032896 21:43:14 INFO - PROCESS | 1648 | 21:46:16 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 21:46:17 INFO - PROCESS | 1648 | RSS: Main: 341889024 21:46:17 INFO - PROCESS | 1648 | 21:49:20 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 21:49:21 INFO - PROCESS | 1648 | RSS: Main: 329428992 21:49:21 INFO - PROCESS | 1648 | 21:52:24 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 21:52:24 INFO - PROCESS | 1648 | RSS: Main: 446550016 21:52:24 INFO - PROCESS | 1648 | 21:52:24 INFO - PROCESS | 1648 | __start_tp_report 21:52:24 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 21:52:24 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 21:52:24 INFO - PROCESS | 1648 | |i|pagename|runs| 21:52:24 INFO - PROCESS | 1648 | |0;dojo.html;2912.810667306625;3219.7102260796532;3256.1859535116223;3265.330607225519;3311.983440082799;5335.599830012745;5363.383210930744;5440.918386224205;5474.042042642542;5515.393306736256;4752.928706069403;5025.763535226825;5074.949250507494;5508.64193827401;5509.862253443666;4996.300517927493;5029.673071250375;5038.748062596856;5072.1630930896545;5126.282320475137;5013.573846223057;5054.342935418391;5069.797208111671;5085.66943148696;5110.054639891632;5129.974350128244;5135.05001574708;5147.794088236466;5183.403908550508;5215.530602245797;354.56763893830123;5136.768845401929;5142.408623008365;5164.767585458663;5177.275181474596;2509.696369744084;4979.004199160183;5010.72441015744;5029.497050294978;5046.116929537353;4566.269396896514;5336.946630533723;5460.26286451328;5462.016836969344;5497.752601132918;5880.26496687914;5889.204957330791;5897;5927.762889484416;5938.138969849348;5814.447627475383;5817.418258174191;5885.617434866763;5946.108083787423;6022.036474164112;4728.952710472886;5540.9168862467095;5544.889102217933;5550.4449555044175;5560.277163968658;6222.346653601307;6230.657313847782;6232.439080482778;6238.750449982041;6243.656598887014;5718.485336319751;5778.104393818965;5778.6821724804695;5813.82558523245;5913.9112913306335;6026.216591843032;6048.60684055535;6058.303295121117;6060.939390606038;6078.969605152034;5872.7357268923;5936.37668044849;5944.227250457413;5947.9702601486715;5978.790742323998;4779.808807647724;5787.247657804459;5981.970090149522;5982.581219314693;5988.490978266809;4734.834280800155;4747.976260118678;4784.40194975628;4789.712617242976;4840.273958906122;4267.893302667396;4272.743635381825;4274.658027357804;4289.991851914798;4324.654027677778;5516.862078448071;5519.254900588449;5531.032069387841;5547.44525547442;5568.248286481355;5825.592208545446;5840.240768700041;5877.206577112121;5931.6441013539325;6009.308929473166;5431.918521222185;5527.8894422112135;5540.722963851791;5574.804881829116;5598.44015598445;4469.642428605704;5235.319408476874;5245.239440281214;5250.684958902478;5252.44849290819;6096.466212027279;6138.204480310071;6310.305866354789;6310.337414571588;6324.9051264231075;5989.520838332835;6020.518358531394;6029.78895738647;6042.75828966854;6129.478994285536;6235.625862448268;6249.406306400884;6298.866204083309;6313.40022697843;6325.493960483058;5930.52555795544;5943.613665111754;5955.40445955401;5969.194158788508;5989.5507836913275;5698.772049117989;5816.1857339973285;5863.706814659165;5866.2960444746905;5923.111533269872;4864.294677271847;5776.942230577809;5792.768289268551;5806.274215723035;5821.592488525763;5786.42135786418;5789.160571716993;5796.797112101225;5801.3038435388025;5812.68030258323;5506.64206826555;5618.185363122243;5630.662160270397;5655.377908430151;5664.065429204135;4843.636727245541;5818.679972601548;5829.504492118217;5871.647701137775;5876.735546900485;4745.264484004984;5519.917201241904;5572.554195664418;5693.174489699053;5709.800156994485 21:52:24 INFO - PROCESS | 1648 | |1;ext.html;498.9700617962925;513.0841448015291;513.8381409855895;518.225253246397;519.3508114856428;30860.845695771517;41052.79473602631;42298.07826904232;42326;44339;42875.14249715012;43087.56912430875;43444.348334775;43459.13081738371;43504.12991740163;9616.278779091579;9771.657991970282;9810.166135878459;9817.410955342666;9818.705438836847;9576;9676.806463870718;9700.417974921527;9708.66019689311;9712.98013708561;9555.187809036206;9684.854727179098;9726.221902247804;9755.463449510275;9762.804743905117;9547.331686781929;9559.665411710557;9679.419234845931;9715.125638692482;9732.854007189897;9575.856362154573;9643.373180743229;9663.565139568736;9664.178544823699;9676.661316853946;32745.508817367758;41457.37813932763;41548.169036619096;41847.58152418467;41871.58128418738;3320.8671653133847;3463.290025544757;3485.442329227337;3590.174259920207;3699.8520059197867;31238.21904452384;31722.682773172204;32282;32395.83802080998;32656.020319390456;3170.5402716605963;3221.5167724841226;3227.7256433203206;3263.7552183586326;3375.8480868360984;482443;486157;489222;489284;497925;61532.07701884475;61911.49929257453;62097.68951155306;62187.37812621906;62260.377396226366;34910.12724681903;35565.8221708895;35604.46593301102;36550.60364436213;36597.451038234445;16288.674226515403;16401.753973690167;16514.42199523035;16520.173991300388;16529.834701652828;12572.559960401342;12679.556215532411;12710.745785084246;12721.491140354467;12726.045546584044;18993.33523326677;19429;19439.708404373945;19449.930253835893;19464.22143114288;6339.461145802658;7584.696612135564;7606.733764318223;7686.5787277008685;7695.961520192475;835.5738573327646;981.3768257156614;982.8574856645889;993.3096497934011;1032.0195813976752;29922.55116173259;30423.695763042087;30704.394942805575;30873;30953.845230774154;1036.5542816588938;1049.1606714628267;1059.9506488576253;1078.7249251440833;1085.6742977106837;15633;15802.89379743407;15811;15846.366145354288;16189.352425902833;557011;559586;561012;562594;567859;58839.41160588425;59303.11045334324;59390.703046484494;59465;59528.404715953155;1197.6107764976418;1285.575759999198;1293.1982171054008;1343.4961889291515;1346.562367230654;28526.288422694706;29140.56289155622;29730.256743581584;30097.548536771526;30826.92105776287;51923;52238.21642675439;52342.738286308326;52410;52501.47498524966;497361;498510;499040;499343;500594;26396.604050939637;26569;26764.788225412296;26770.19689409321;26811.865940670952;46109.53890461053;47429.28856067231;48705.26942095942;48768;48792.512074880215;38682.80658596689;39252.42990280357;39338.016549586486;40830.387544187455;40842;39140.60859391483;39252.214955701296;39347.409788852616;40134.598654014255;40397.59602403938;33148.00555983324;33629.83185084059;33743;37795;38853.41719874261;29785;34809.955701329;35014.82492587521;35293.47059794157;36162.91511254667;25595.232143035737;25621.743782561934;25835.484546152296;25837.354066147745;26181.60727589126 21:52:24 INFO - PROCESS | 1648 | |2;jquery.html;310.65362121234824;352.2813460540498;364.75436384746087;370.5775416025731;398.6392314954967;14697.853021469782;14948.177850218233;15695.92152039241;17520.299188032495;20352.592948141064;18895.33866314679;19134.71297930532;20580.794192058074;20841.791582084214;20907.58184836306;4628.352030715694;5498.158117030799;5500.724963751796;5505.03661859173;5510.614257002011;4572.08558288342;5525.668459892399;6098.176746139281;6145.078238264251;6174.073888916653;5394.622376433651;6111.847203819918;6129.908051379233;6133.815985520441;6137.018077107641;5397.811076612319;5468.99999999998;5481.150421684645;5488.835334939959;5501.669899806025;5052.545270925598;5322;5325.121354976424;5327.30745003151;5331.920021199685;12919.418626161845;13117.934410327982;13163.407646655924;13182.538611148564;13186.208827470287;2199;2220.9444763881033;2322.512272422793;2586.2887705880844;2721.18364490652;9970.551325190312;10031.648892288807;10379.84430233547;10565.049145576859;15763.527094187193;1586.4923224568142;1872.3353209610527;1875.3061367294051;1881.67070762616;1975.8913259770707;68562.3143768561;77142.84285735719;80765;82842;115767.42116289449;11247.550097996153;11254.268472549258;11433.485493152828;11447.141464390204;11575.942120289345;14312.928435357757;14368;14391.640208994859;14405.351759170862;14424.278786060655;7253.673584688701;8361.205685459872;8370.665173393118;8518.57407129641;8523.232909038092;8197.549134797524;8231.835363292821;8235.50586964772;8411.327093832479;8420.242178203991;3725.2735716535017;4482.139911936575;4488.483824360175;4527.524609915978;4553.248713962225;1853.184598776534;1905.3140869287045;1912.1490936533387;1951.3560525026708;1954.5113721569608;845.9957700211583;858.8840506531664;912.8128733609594;978.7063880835863;1012.0941757127476;19932.50168745793;20202.09090590927;20645.72896981331;21273.893630532057;21640.783592164193;874.9518776467355;906.4561263242002;911.3757076402685;935.2564711054591;955.6559638530124;10400.843987340197;10661.09380702649;11227.71930701739;11254.324740515594;11267.718307042389;482966;603369.9831500902;619464.9026754928;619662;620499;76644.85032724513;97981;103647.48176259222;123682;125311;871.7820544863785;898.0929261445856;955.6846240740539;959.2182371367313;964.4599024546136;17850.107494624957;19062.142203600593;19422.320218792276;19470;19776.505587359854;53206.73396632992;53741;54128.458715412344;54197.72901135469;54758;76990.6150469244;77036.61481692556;77839;78038.2196178031;78329;5268.4994925482015;5341.679499230058;6277.591956522811;6645.776798252747;6739.59562426256;7596.24037596258;9403.482808445327;12560.623181304576;12864;13230.470781168646;10381.480925953823;11069.169812263952;11517;11574.30554166719;11617.128715346551;5921;11037.227394082338;11056.557737690402;11378;11393.943030284796;11200.38397888124;11283.323000619988;11434.656960291204;11812.881871181178;11905.404729763304;6960.37356637905;7425.220351862977;7471.290227428385;7575.356094732009;7733.690652374067;10731.785364292515;11121.05471034971;11213.60752373663;11618.817225798537;11655.88344116548 21:52:24 INFO - PROCESS | 1648 | |3;mootools.html;1277.195366918841;1480.4744315767903;1597.5926138834602;1802.1169626882831;1868.093974422405;8419.947506561679;8918.375713700027;8922.86615700765;8937.061608531109;8951.955240223799;7795.454318197729;8048.114707382198;8055.879161812578;8216.301614362786;8693.217610415062;2116.206422591532;2151.451379898124;2258.706368172135;2349.800266977309;2359.905603775847;2358.79950204232;2365.053978408633;2367.372646248737;2368.917087901924;2373.774491423312;2317.165820304689;2339.0643742502966;2360.6695062691238;2362.1024010875844;2371.5019845832394;2253.9436514087197;2255.1430456426533;2269.251147121446;2347.6595893595504;2350.576896158691;2308.8845557722047;2326.430024643956;2332.3119679694532;2339.5905716499547;2348.9530209395716;8695.217430431228;8868.911310886873;8876.600552975067;8884.644614215424;8895.377323587352;5122.359705036871;5294.7617357219015;5294.867628309323;5297.841064768063;5300;3412.2322477442626;3557.3418917500344;3622.5290712207243;3626.6373362663785;3631.346357655621;1016.8627235323211;1030.6392762533128;1051.0645525482328;1070.0743856564093;1074.51646758958;11655.067594592412;11734.94132529332;11752.001079908217;11777.528898844035;11782.88217117835;4438.845900065941;4558.9772051139535;4758.500357462417;4766.332713420124;4768.6661933665;9886.456244906456;9902.851457228147;9909.108180263811;9913.206943444507;9939.850902236472;5299.33758280215;5303.4696530346655;5309.5752339812725;5314.176302673091;5368.758405871745;4731.503192164842;4807.351007613927;4861.978984413313;4869.440014398389;4880.121578115903;3567.4470457079196;3704.1294146456407;3709.7774133552075;3757.1922036762226;3826.9808650957125;1042.1506472225112;1251.217988757027;1257.251935098615;1258.383392137846;1273.331500961984;618.9071639254058;775.9418043646749;891.8662200669952;902.4089221559889;954.5513608603945;5766.279215098113;5813.651180929158;5953.404659534012;6013.9699301503215;6181.412765787243;900.6802585082332;955.6225291010012;967.1730670276953;987.7481242283171;1019.8113349030453;3794.9810250948567;3841.7310788244554;3874.9806250968563;3934.881953541398;3964.1278918637854;10621.2034097443;10667.733306667395;10695.358278503314;10899.073578745736;10940.617078402218;10773;10833.67498975032;10842.783144337069;10868.565257389615;10899.346039237671;7802.609869506502;8080.676772929134;8100.18998100197;8278;8291.419600628018;5924.407559244041;6007.729652165575;6019.548533860066;6045.727942242697;6175.722092505938;9896.158826499828;9993.900060999296;10044.146247569039;10186.745331366776;10217.846732298873;9919.702408927744;10224.744381390525;10227.335223210468;10285;10404.814988852124;7227.241139680468;7453.552786832807;7570.318671319607;7627.580483073484;7650.846983060196;7448.441366897396;7702.768916932501;7718.57547834852;8229.629666664894;8314.87527687073;6877.764726464019;7388.1503627083575;7459.36595389398;7547.207543207884;7572.20491848348;7235.891461627974;7313.232110628307;7327.2672732726305;7384.852302953804;7398.852022959403;6857.485688573277;6977.197622273504;6980.197277312971;6983.44132469391;6989.231184569591;4870.889691007882;4876.90246195067;4900.803967841389;4995.675281106716;5112.6165537585575;4748.9050218994735;5006.924896126634;5073.492650734897;5081.23781432788;5166.483351664803 21:52:24 INFO - PROCESS | 1648 | |4;prototype.html;251.46061697658524;297.7722042637384;306.8557777844414;311.5638106650689;315.4038866542234;4173.707840451166;4900.289458028588;4961.5286547777905;5113.923291150626;5229.529342359187;5047.873803154923;5096.79612815487;5182.253405694978;5215.757224393509;5262.2632831403635;3770.396736522157;4017.3973903914502;4032.5967403259733;4036.5559788423398;4040.030392705759;3607.9098022549383;3772.4718539404507;4051.210014047262;4052.837886484537;4073.226087043467;3367.4948757686298;3933.7743050698436;3974.463447434588;3992.7223288547675;4011.3352958522323;3288.671132886704;3978.2839088963974;3983;3988.78061706606;3999.5200575931076;3168.30297334586;3213.9467505869516;3460.9790111917046;3515.91006787894;3519.964800351989;4423.557644235583;4692.648051396159;4830.6135509159185;5020.799168033274;5089;4259.616634502879;4388.275934470808;4493.910121797546;4496.865094047183;4510.233260345716;4742.668013239075;5022.844745708471;5201.505856943584;5500.339959204881;5501.9174712379345;3351.731861451078;3592.2995015971896;3702.8889133326043;3708.7218458615444;3770;4718.646101542364;5692.7153642318135;5748.396418376052;5751.009475072939;5778.971105144447;3473.1838018065732;3711.6473934976134;3766.2844059629133;3820.6561409472724;3838.673712734393;3563.592381009487;3571.8571257149424;3868.4777555030273;3882.3011857865854;3885.4171874218528;4449.733016018984;4464.866054018385;4468.553144685506;4483.551644835556;4512.796924138422;4769.523047695272;5488.890222195534;5512;5548.029094908375;5578.30271216098;1247.4822948476462;1281.7180220351509;1282.5190553542423;1294.152330223705;1323.1597935310954;708.8429868907988;722.4220623501283;814.6822739131743;826.3430572694722;830.8462934357163;3581.4627805828814;3670.5595328560744;4015.257177422186;4353.32523458858;4381.9123617527475;4215.557366476537;4710.481846996828;4736;4764.833230836974;4806.49531799156;3826.5025546678753;3966.4050392440786;4323.567643235714;4336.978315108404;4348;2244.1696572268365;2300.9309720708407;2301.2405906050963;2429.4047958250344;2495.7645965246957;4145.7719825409895;4316.956830431718;4675.719456832533;4886.877828054327;4917.852464426073;3897.512810898638;4384.539623339503;4748.50422117032;4813.229883218738;4813.687110337817;4011.659008984269;4281.293586558245;4429.490608580055;4851.466338702739;4891.241857512091;3889.805509724559;4619.653525985632;4654.18551753435;4699.76501174933;4725.551072648231;4094.1924010670364;4101.651359634465;4138.193052354762;4390.868273951786;4623.953760462352;4021.537523184871;4245.95754042468;4369.84199187222;4530.818767249273;4873.975630121827;2722.414680843628;3167.8416079195486;3176.698213669698;3302.1579497228054;3305.3719793239206;3925.666318362971;4346.391835021062;4415.911681766411;4702.811887524461;4767.61859051282;3691.784929042553;4557.840475583339;4567.543245675406;4601.585857272861;4665.4634717007975;4132.979335103426;4412.338149277634;4560.703554268962;4588.678792484494;4588.977055114703;3981.144054028398;4004.599540045972;4119.958800411958;4195.035141917315;4505.139236584727;4481.887952801206;4714.81140754366;5389.407165211902;5403.649087728068;5415.891682166413;4897.608191344612;5341.4925582069645;5386.165144402624;5397.78408863641;5404.891902161856 21:52:24 INFO - PROCESS | 1648 | |5;yui.html;693.1024323501066;695.749530169139;708.9255628159043;747.3175753256521;795.5346122518326;15070.924645376772;15596.986195897287;15605.375784968615;15666.530004099866;15692.52922412328;13530.008647449002;13538.661533461669;13545.322733863317;13548.916086713063;13649.044566880322;610.4902406490586;666.1939053744975;691.7475121580612;691.9723211071577;843.4348986179275;838.6351936907465;847.0470720439506;854.850401179791;854.8504011797942;861.1431625532604;908.995455022724;911.5305617606938;912.9726108216764;913.4427998920653;916.2852974679761;704.1866644026157;729.3472342253706;901.9458832470007;904.9140331668481;905.4250550900193;536.9758360873731;538.5987439357704;538.8518157506678;539.7436217796554;637.1430426076919;14402.423903043866;14900.105993640416;14908;14948.252587370587;14959.252037398195;13243.86756132436;13528.25594592297;13599.864001359958;13821.447142114303;13968;12363.381830908418;12424.641673653474;12482.251064936043;12538.749225015448;12961.351932403437;4470.307102399133;4488.259437192859;4562.973331000531;4686.5782079613;4693.319468677057;102678;119003.4049829754;120057;123774;123853.38073309665;10679.626213082505;10767.407792571326;10793.568257269779;10873.347599144077;10947.069499092666;21459.141634334763;21472.24847130343;21489.78510214909;21541.67687484689;21576;7612.276833700789;7624;7799.298063174341;7906.209379062047;8032.558209298428;4250.978745106255;4267.295896177096;4308.246056940023;4355.869323920288;4447.911041779146;3410.1474631342167;3524.242287908112;3530.770499917497;3533.4876442915634;3534.2401383702627;522.1343834797868;629.0532748213909;636.4431122767578;637.7799659117597;638.3170008091298;491.5354989534855;560.4352548492586;598.5750117416683;617.5677026081761;620.1287191495956;8704.695335663222;8812;8820.029796722356;8826.823463530693;9200.495924555755;568.7525926222106;576.2393640394722;605.4732382826969;609.8597322615823;642.4057746584391;4112.506499220053;4300.204462174508;4370.38814565961;4450.621697155713;4468.888277793016;157833;160428.19785900996;163785;169593;175799;38133;66338;101590;126536.36731816283;132978;77785.2221477778;89212;97892.51053744685;99553;107496.8500629983;9501.952490237505;9662.661806836726;9911.603535858485;9922.751931201778;9966.352187107816;53787.6553086176;55046;55289;56338;64158.679206603665;61564;62596.374036259054;67401;78375;81615;10845.620403285848;10933.398663073607;11249;11358.318500889642;11496.195266331277;14151.43394264218;14477.203753793221;14708.485203018272;15128.697426051198;15442.30509627092;13253.933730331672;13983.510577129751;14024.158550487004;14602.269886505845;14766.926165369105;11384.829227561759;11453.427328633701;12175.443306041687;13058.34708264564;13651.11267767592;13706;13831.515896943962;13833.239171845646;13931.233782141675;14125.929370353082;9807.509624518603;11166.49750761234;11491.942540287246;11574.321723349898;12147.817782733442;10871.130309575374;11449.771004580029;11543.88456115428;11710.4730287139;11738.178327516991 21:52:24 INFO - PROCESS | 1648 | __end_tp_report 21:52:24 INFO - PROCESS | 1648 | __start_cc_report 21:52:24 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1269 21:52:24 INFO - PROCESS | 1648 | __end_cc_report 21:52:24 INFO - PROCESS | 1648 | __startTimestamp1476334344630__endTimestamp 21:52:24 INFO - PROCESS | 1648 | 21:52:24 INFO - PROCESS | 1648 | ------- Summary: start ------- 21:52:24 INFO - PROCESS | 1648 | Number of tests: 6 21:52:24 INFO - PROCESS | 1648 | 21:52:24 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5441.42 Median:5618.19 stddev:783.19 (13.9%) stddev-sans-first:760.05 21:52:24 INFO - PROCESS | 1648 | Values: 2912.8 3219.7 3256.2 3265.3 3312.0 5335.6 5363.4 5440.9 5474.0 5515.4 4752.9 5025.8 5074.9 5508.6 5509.9 4996.3 5029.7 5038.7 5072.2 5126.3 5013.6 5054.3 5069.8 5085.7 5110.1 5130.0 5135.1 5147.8 5183.4 5215.5 354.6 5136.8 5142.4 5164.8 5177.3 2509.7 4979.0 5010.7 5029.5 5046.1 4566.3 5336.9 5460.3 5462.0 5497.8 5880.3 5889.2 5897.0 5927.8 5938.1 5814.4 5817.4 5885.6 5946.1 6022.0 4729.0 5540.9 5544.9 5550.4 5560.3 6222.3 6230.7 6232.4 6238.8 6243.7 5718.5 5778.1 5778.7 5813.8 5913.9 6026.2 6048.6 6058.3 6060.9 6079.0 5872.7 5936.4 5944.2 5948.0 5978.8 4779.8 5787.2 5982.0 5982.6 5988.5 4734.8 4748.0 4784.4 4789.7 4840.3 4267.9 4272.7 4274.7 4290.0 4324.7 5516.9 5519.3 5531.0 5547.4 5568.2 5825.6 5840.2 5877.2 5931.6 6009.3 5431.9 5527.9 5540.7 5574.8 5598.4 4469.6 5235.3 5245.2 5250.7 5252.4 6096.5 6138.2 6310.3 6310.3 6324.9 5989.5 6020.5 6029.8 6042.8 6129.5 6235.6 6249.4 6298.9 6313.4 6325.5 5930.5 5943.6 5955.4 5969.2 5989.6 5698.8 5816.2 5863.7 5866.3 5923.1 4864.3 5776.9 5792.8 5806.3 5821.6 5786.4 5789.2 5796.8 5801.3 5812.7 5506.6 5618.2 5630.7 5655.4 5664.1 4843.6 5818.7 5829.5 5871.6 5876.7 4745.3 5519.9 5572.6 5693.2 5709.8 21:52:24 INFO - PROCESS | 1648 | 21:52:24 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:65415.15 Median:40613.99 stddev:137791.41 (339.3%) stddev-sans-first:138091.75 21:52:24 INFO - PROCESS | 1648 | Values: 499.0 513.1 513.8 518.2 519.4 30860.8 41052.8 42298.1 42326.0 44339.0 42875.1 43087.6 43444.3 43459.1 43504.1 9616.3 9771.7 9810.2 9817.4 9818.7 9576.0 9676.8 9700.4 9708.7 9713.0 9555.2 9684.9 9726.2 9755.5 9762.8 9547.3 9559.7 9679.4 9715.1 9732.9 9575.9 9643.4 9663.6 9664.2 9676.7 32745.5 41457.4 41548.2 41847.6 41871.6 3320.9 3463.3 3485.4 3590.2 3699.9 31238.2 31722.7 32282.0 32395.8 32656.0 3170.5 3221.5 3227.7 3263.8 3375.8 482443.0 486157.0 489222.0 489284.0 497925.0 61532.1 61911.5 62097.7 62187.4 62260.4 34910.1 35565.8 35604.5 36550.6 36597.5 16288.7 16401.8 16514.4 16520.2 16529.8 12572.6 12679.6 12710.7 12721.5 12726.0 18993.3 19429.0 19439.7 19449.9 19464.2 6339.5 7584.7 7606.7 7686.6 7696.0 835.6 981.4 982.9 993.3 1032.0 29922.6 30423.7 30704.4 30873.0 30953.8 1036.6 1049.2 1060.0 1078.7 1085.7 15633.0 15802.9 15811.0 15846.4 16189.4 557011.0 559586.0 561012.0 562594.0 567859.0 58839.4 59303.1 59390.7 59465.0 59528.4 1197.6 1285.6 1293.2 1343.5 1346.6 28526.3 29140.6 29730.3 30097.5 30826.9 51923.0 52238.2 52342.7 52410.0 52501.5 497361.0 498510.0 499040.0 499343.0 500594.0 26396.6 26569.0 26764.8 26770.2 26811.9 46109.5 47429.3 48705.3 48768.0 48792.5 38682.8 39252.4 39338.0 40830.4 40842.0 39140.6 39252.2 39347.4 40134.6 40397.6 33148.0 33629.8 33743.0 37795.0 38853.4 29785.0 34810.0 35014.8 35293.5 36162.9 25595.2 25621.7 25835.5 25837.4 26181.6 21:52:24 INFO - PROCESS | 1648 | 21:52:24 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:32660.63 Median:2061.96 stddev:97849.92 (4745.5%) stddev-sans-first:98094.27 21:52:24 INFO - PROCESS | 1648 | Values: 310.7 352.3 364.8 370.6 398.6 14697.9 14948.2 15695.9 17520.3 20352.6 18895.3 19134.7 20580.8 20841.8 20907.6 4628.4 5498.2 5500.7 5505.0 5510.6 4572.1 5525.7 6098.2 6145.1 6174.1 5394.6 6111.8 6129.9 6133.8 6137.0 5397.8 5469.0 5481.2 5488.8 5501.7 5052.5 5322.0 5325.1 5327.3 5331.9 12919.4 13117.9 13163.4 13182.5 13186.2 2199.0 2220.9 2322.5 2586.3 2721.2 9970.6 10031.6 10379.8 10565.0 15763.5 1586.5 1872.3 1875.3 1881.7 1975.9 68562.3 77142.8 80765.0 82842.0 115767.4 11247.6 11254.3 11433.5 11447.1 11575.9 14312.9 14368.0 14391.6 14405.4 14424.3 7253.7 8361.2 8370.7 8518.6 8523.2 8197.5 8231.8 8235.5 8411.3 8420.2 3725.3 4482.1 4488.5 4527.5 4553.2 1853.2 1905.3 1912.1 1951.4 1954.5 846.0 858.9 912.8 978.7 1012.1 19932.5 20202.1 20645.7 21273.9 21640.8 875.0 906.5 911.4 935.3 955.7 10400.8 10661.1 11227.7 11254.3 11267.7 482966.0 603370.0 619464.9 619662.0 620499.0 76644.9 97981.0 103647.5 123682.0 125311.0 871.8 898.1 955.7 959.2 964.5 17850.1 19062.1 19422.3 19470.0 19776.5 53206.7 53741.0 54128.5 54197.7 54758.0 76990.6 77036.6 77839.0 78038.2 78329.0 5268.5 5341.7 6277.6 6645.8 6739.6 7596.2 9403.5 12560.6 12864.0 13230.5 10381.5 11069.2 11517.0 11574.3 11617.1 5921.0 11037.2 11056.6 11378.0 11393.9 11200.4 11283.3 11434.7 11812.9 11905.4 6960.4 7425.2 7471.3 7575.4 7733.7 10731.8 11121.1 11213.6 11618.8 11655.9 21:52:24 INFO - PROCESS | 1648 | 21:52:24 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5693.63 Median:4890.46 stddev:3214.82 (65.7%) stddev-sans-first:3206.71 21:52:24 INFO - PROCESS | 1648 | Values: 1277.2 1480.5 1597.6 1802.1 1868.1 8419.9 8918.4 8922.9 8937.1 8952.0 7795.5 8048.1 8055.9 8216.3 8693.2 2116.2 2151.5 2258.7 2349.8 2359.9 2358.8 2365.1 2367.4 2368.9 2373.8 2317.2 2339.1 2360.7 2362.1 2371.5 2253.9 2255.1 2269.3 2347.7 2350.6 2308.9 2326.4 2332.3 2339.6 2349.0 8695.2 8868.9 8876.6 8884.6 8895.4 5122.4 5294.8 5294.9 5297.8 5300.0 3412.2 3557.3 3622.5 3626.6 3631.3 1016.9 1030.6 1051.1 1070.1 1074.5 11655.1 11734.9 11752.0 11777.5 11782.9 4438.8 4559.0 4758.5 4766.3 4768.7 9886.5 9902.9 9909.1 9913.2 9939.9 5299.3 5303.5 5309.6 5314.2 5368.8 4731.5 4807.4 4862.0 4869.4 4880.1 3567.4 3704.1 3709.8 3757.2 3827.0 1042.2 1251.2 1257.3 1258.4 1273.3 618.9 775.9 891.9 902.4 954.6 5766.3 5813.7 5953.4 6014.0 6181.4 900.7 955.6 967.2 987.7 1019.8 3795.0 3841.7 3875.0 3934.9 3964.1 10621.2 10667.7 10695.4 10899.1 10940.6 10773.0 10833.7 10842.8 10868.6 10899.3 7802.6 8080.7 8100.2 8278.0 8291.4 5924.4 6007.7 6019.5 6045.7 6175.7 9896.2 9993.9 10044.1 10186.7 10217.8 9919.7 10224.7 10227.3 10285.0 10404.8 7227.2 7453.6 7570.3 7627.6 7650.8 7448.4 7702.8 7718.6 8229.6 8314.9 6877.8 7388.2 7459.4 7547.2 7572.2 7235.9 7313.2 7327.3 7384.9 7398.9 6857.5 6977.2 6980.2 6983.4 6989.2 4870.9 4876.9 4900.8 4995.7 5112.6 4748.9 5006.9 5073.5 5081.2 5166.5 21:52:24 INFO - PROCESS | 1648 | 21:52:24 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4034.41 Median:4361.58 stddev:1203.32 (27.6%) stddev-sans-first:1172.72 21:52:24 INFO - PROCESS | 1648 | Values: 251.5 297.8 306.9 311.6 315.4 4173.7 4900.3 4961.5 5113.9 5229.5 5047.9 5096.8 5182.3 5215.8 5262.3 3770.4 4017.4 4032.6 4036.6 4040.0 3607.9 3772.5 4051.2 4052.8 4073.2 3367.5 3933.8 3974.5 3992.7 4011.3 3288.7 3978.3 3983.0 3988.8 3999.5 3168.3 3213.9 3461.0 3515.9 3520.0 4423.6 4692.6 4830.6 5020.8 5089.0 4259.6 4388.3 4493.9 4496.9 4510.2 4742.7 5022.8 5201.5 5500.3 5501.9 3351.7 3592.3 3702.9 3708.7 3770.0 4718.6 5692.7 5748.4 5751.0 5779.0 3473.2 3711.6 3766.3 3820.7 3838.7 3563.6 3571.9 3868.5 3882.3 3885.4 4449.7 4464.9 4468.6 4483.6 4512.8 4769.5 5488.9 5512.0 5548.0 5578.3 1247.5 1281.7 1282.5 1294.2 1323.2 708.8 722.4 814.7 826.3 830.8 3581.5 3670.6 4015.3 4353.3 4381.9 4215.6 4710.5 4736.0 4764.8 4806.5 3826.5 3966.4 4323.6 4337.0 4348.0 2244.2 2300.9 2301.2 2429.4 2495.8 4145.8 4317.0 4675.7 4886.9 4917.9 3897.5 4384.5 4748.5 4813.2 4813.7 4011.7 4281.3 4429.5 4851.5 4891.2 3889.8 4619.7 4654.2 4699.8 4725.6 4094.2 4101.7 4138.2 4390.9 4624.0 4021.5 4246.0 4369.8 4530.8 4874.0 2722.4 3167.8 3176.7 3302.2 3305.4 3925.7 4346.4 4415.9 4702.8 4767.6 3691.8 4557.8 4567.5 4601.6 4665.5 4133.0 4412.3 4560.7 4588.7 4589.0 3981.1 4004.6 4120.0 4195.0 4505.1 4481.9 4714.8 5389.4 5403.6 5415.9 4897.6 5341.5 5386.2 5397.8 5404.9 21:52:24 INFO - PROCESS | 1648 | 21:52:24 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:23308.80 Median:4259.14 stddev:38149.44 (895.7%) stddev-sans-first:38218.67 21:52:24 INFO - PROCESS | 1648 | Values: 693.1 695.7 708.9 747.3 795.5 15070.9 15597.0 15605.4 15666.5 15692.5 13530.0 13538.7 13545.3 13548.9 13649.0 610.5 666.2 691.7 692.0 843.4 838.6 847.0 854.9 854.9 861.1 909.0 911.5 913.0 913.4 916.3 704.2 729.3 901.9 904.9 905.4 537.0 538.6 538.9 539.7 637.1 14402.4 14900.1 14908.0 14948.3 14959.3 13243.9 13528.3 13599.9 13821.4 13968.0 12363.4 12424.6 12482.3 12538.7 12961.4 4470.3 4488.3 4563.0 4686.6 4693.3 102678.0 119003.4 120057.0 123774.0 123853.4 10679.6 10767.4 10793.6 10873.3 10947.1 21459.1 21472.2 21489.8 21541.7 21576.0 7612.3 7624.0 7799.3 7906.2 8032.6 4251.0 4267.3 4308.2 4355.9 4447.9 3410.1 3524.2 3530.8 3533.5 3534.2 522.1 629.1 636.4 637.8 638.3 491.5 560.4 598.6 617.6 620.1 8704.7 8812.0 8820.0 8826.8 9200.5 568.8 576.2 605.5 609.9 642.4 4112.5 4300.2 4370.4 4450.6 4468.9 157833.0 160428.2 163785.0 169593.0 175799.0 38133.0 66338.0 101590.0 126536.4 132978.0 77785.2 89212.0 97892.5 99553.0 107496.9 9502.0 9662.7 9911.6 9922.8 9966.4 53787.7 55046.0 55289.0 56338.0 64158.7 61564.0 62596.4 67401.0 78375.0 81615.0 10845.6 10933.4 11249.0 11358.3 11496.2 14151.4 14477.2 14708.5 15128.7 15442.3 13253.9 13983.5 14024.2 14602.3 14766.9 11384.8 11453.4 12175.4 13058.3 13651.1 13706.0 13831.5 13833.2 13931.2 14125.9 9807.5 11166.5 11491.9 11574.3 12147.8 10871.1 11449.8 11543.9 11710.5 11738.2 21:52:24 INFO - PROCESS | 1648 | -------- Summary: end -------- 21:52:24 INFO - PROCESS | 1648 | 21:52:25 INFO - TEST-INFO | 1648: exit 0 21:52:25 INFO - TEST-OK | dromaeo_css | took 1117973ms 21:52:25 INFO - TEST-START | kraken 21:52:25 INFO - operating with platform_type : mac_ 21:52:25 INFO - Initialising browser for kraken test... 21:52:25 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/tmpCPJ5LA/profile http://localhost:49276/getInfo.html) 21:52:27 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 21:52:27 INFO - PROCESS | 1657 | colorDepth:24 21:52:27 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 21:52:27 INFO - PROCESS | 1657 | __metrics 21:52:27 INFO - PROCESS | 1657 | 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" 21:52:27 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:52:28 INFO - TEST-INFO | 1657: exit 0 21:52:28 INFO - Browser initialized. 21:52:28 INFO - Running cycle 1/1 for kraken test... 21:52:28 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/T/tmpCPJ5LA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:52:40 INFO - PROCESS | 1658 | RSS: Main: 243531776 21:52:40 INFO - PROCESS | 1658 | 21:52:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 21:52:43 INFO - PROCESS | 1658 | RSS: Main: 293597184 21:52:43 INFO - PROCESS | 1658 | 21:52:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 21:52:47 INFO - PROCESS | 1658 | RSS: Main: 293580800 21:52:47 INFO - PROCESS | 1658 | 21:52:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 21:52:51 INFO - PROCESS | 1658 | RSS: Main: 383209472 21:52:51 INFO - PROCESS | 1658 | 21:52:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 21:52:54 INFO - PROCESS | 1658 | RSS: Main: 284073984 21:52:54 INFO - PROCESS | 1658 | 21:52:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:52:56 INFO - PROCESS | 1658 | RSS: Main: 288247808 21:52:56 INFO - PROCESS | 1658 | 21:52:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 21:52:59 INFO - PROCESS | 1658 | RSS: Main: 326483968 21:52:59 INFO - PROCESS | 1658 | 21:53:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 21:53:03 INFO - PROCESS | 1658 | RSS: Main: 328413184 21:53:03 INFO - PROCESS | 1658 | 21:53:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 21:53:06 INFO - PROCESS | 1658 | RSS: Main: 326664192 21:53:06 INFO - PROCESS | 1658 | 21:53:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:53:08 INFO - PROCESS | 1658 | RSS: Main: 302891008 21:53:08 INFO - PROCESS | 1658 | 21:53:10 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:53:11 INFO - PROCESS | 1658 | RSS: Main: 306761728 21:53:11 INFO - PROCESS | 1658 | 21:53:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:53:14 INFO - PROCESS | 1658 | RSS: Main: 308936704 21:53:14 INFO - PROCESS | 1658 | 21:53:16 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:53:17 INFO - PROCESS | 1658 | RSS: Main: 326492160 21:53:17 INFO - PROCESS | 1658 | 21:53:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:53:21 INFO - PROCESS | 1658 | RSS: Main: 320589824 21:53:21 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 21:53:23 INFO - PROCESS | 1658 | RSS: Main: 364466176 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | __start_tp_report 21:53:23 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 21:53:23 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 21:53:23 INFO - PROCESS | 1658 | |i|pagename|runs| 21:53:23 INFO - PROCESS | 1658 | |0;ai-astar;111;113;113;113;111;112;114;114;113;113 21:53:23 INFO - PROCESS | 1658 | |1;audio-beat-detection;151;112;111;150;114;112;114;110;143;113 21:53:23 INFO - PROCESS | 1658 | |2;audio-dft;183;180;182;184;181;188;182;181;213;198 21:53:23 INFO - PROCESS | 1658 | |3;audio-fft;78;59;58;86;61;59;61;81;110;83 21:53:23 INFO - PROCESS | 1658 | |4;audio-oscillator;84;71;92;71;69;71;117;53;55;74 21:53:23 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;89;86;88;85;87;84;89;85;87;87 21:53:23 INFO - PROCESS | 1658 | |6;imaging-darkroom;93;92;94;93;93;93;94;94;93;93 21:53:23 INFO - PROCESS | 1658 | |7;imaging-desaturate;86;85;83;83;84;82;85;83;84;86 21:53:23 INFO - PROCESS | 1658 | |8;json-parse-financial;56;55;55;55;53;55;54;54;55;54 21:53:23 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;69;71;64;74;74;69;69;73;69;71 21:53:23 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;86;83;84;86;89;85;86;84;86;90 21:53:23 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;147;146;146;143;138;145;146;142;178;141 21:53:23 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;173;171;172;170;171;152;194;229;171;171 21:53:23 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;69;69;66;67;66;68;67;68;68 21:53:23 INFO - PROCESS | 1658 | __end_tp_report 21:53:23 INFO - PROCESS | 1658 | __start_cc_report 21:53:23 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1989 21:53:23 INFO - PROCESS | 1658 | __end_cc_report 21:53:23 INFO - PROCESS | 1658 | __startTimestamp1476334403310__endTimestamp 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | ------- Summary: start ------- 21:53:23 INFO - PROCESS | 1658 | Number of tests: 14 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.06 (0.9%) stddev-sans-first:0.93 21:53:23 INFO - PROCESS | 1658 | Values: 111.0 113.0 113.0 113.0 111.0 112.0 114.0 114.0 113.0 113.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:123.00 Median:114.00 stddev:17.42 (15.3%) stddev-sans-first:15.24 21:53:23 INFO - PROCESS | 1658 | Values: 151.0 112.0 111.0 150.0 114.0 112.0 114.0 110.0 143.0 113.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:187.20 Median:183.50 stddev:10.51 (5.7%) stddev-sans-first:11.03 21:53:23 INFO - PROCESS | 1658 | Values: 183.0 180.0 182.0 184.0 181.0 188.0 182.0 181.0 213.0 198.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:73.60 Median:69.50 stddev:17.09 (24.6%) stddev-sans-first:18.05 21:53:23 INFO - PROCESS | 1658 | Values: 78.0 59.0 58.0 86.0 61.0 59.0 61.0 81.0 110.0 83.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:71.00 stddev:18.55 (26.1%) stddev-sans-first:19.43 21:53:23 INFO - PROCESS | 1658 | Values: 84.0 71.0 92.0 71.0 69.0 71.0 117.0 53.0 55.0 74.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:87.00 stddev:1.70 (2.0%) stddev-sans-first:1.59 21:53:23 INFO - PROCESS | 1658 | Values: 89.0 86.0 88.0 85.0 87.0 84.0 89.0 85.0 87.0 87.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 21:53:23 INFO - PROCESS | 1658 | Values: 93.0 92.0 94.0 93.0 93.0 93.0 94.0 94.0 93.0 93.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.50 stddev:1.37 (1.6%) stddev-sans-first:1.27 21:53:23 INFO - PROCESS | 1658 | Values: 86.0 85.0 83.0 83.0 84.0 82.0 85.0 83.0 84.0 86.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.84 (1.5%) stddev-sans-first:0.73 21:53:23 INFO - PROCESS | 1658 | Values: 56.0 55.0 55.0 55.0 53.0 55.0 54.0 54.0 55.0 54.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:71.00 stddev:3.02 (4.3%) stddev-sans-first:3.17 21:53:23 INFO - PROCESS | 1658 | Values: 69.0 71.0 64.0 74.0 74.0 69.0 69.0 73.0 69.0 71.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:2.18 (2.5%) stddev-sans-first:2.32 21:53:23 INFO - PROCESS | 1658 | Values: 86.0 83.0 84.0 86.0 89.0 85.0 86.0 84.0 86.0 90.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:146.00 stddev:11.18 (7.7%) stddev-sans-first:11.86 21:53:23 INFO - PROCESS | 1658 | Values: 147.0 146.0 146.0 143.0 138.0 145.0 146.0 142.0 178.0 141.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:171.50 stddev:20.68 (12.1%) stddev-sans-first:21.88 21:53:23 INFO - PROCESS | 1658 | Values: 173.0 171.0 172.0 170.0 171.0 152.0 194.0 229.0 171.0 171.0 21:53:23 INFO - PROCESS | 1658 | 21:53:23 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 21:53:23 INFO - PROCESS | 1658 | Values: 68.0 69.0 69.0 66.0 67.0 66.0 68.0 67.0 68.0 68.0 21:53:23 INFO - PROCESS | 1658 | -------- Summary: end -------- 21:53:23 INFO - PROCESS | 1658 | 21:53:24 INFO - TEST-INFO | 1658: exit 0 21:53:24 INFO - TEST-OK | kraken | took 58806ms 21:53:24 INFO - SUITE-END | took 1176s 21:53:24 INFO - Completed test suite (00:19:37) 21:53:24 INFO - javascript benchmark 21:53:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2912.810667306625, 3219.7102260796532, 3256.1859535116223, 3265.330607225519, 3311.983440082799, 5335.599830012745, 5363.383210930744, 5440.918386224205, 5474.042042642542, 5515.393306736256, 4752.928706069403, 5025.763535226825, 5074.949250507494, 5508.64193827401, 5509.862253443666, 4996.300517927493, 5029.673071250375, 5038.748062596856, 5072.1630930896545, 5126.282320475137, 5013.573846223057, 5054.342935418391, 5069.797208111671, 5085.66943148696, 5110.054639891632, 5129.974350128244, 5135.05001574708, 5147.794088236466, 5183.403908550508, 5215.530602245797, 354.56763893830123, 5136.768845401929, 5142.408623008365, 5164.767585458663, 5177.275181474596, 2509.696369744084, 4979.004199160183, 5010.72441015744, 5029.497050294978, 5046.116929537353, 4566.269396896514, 5336.946630533723, 5460.26286451328, 5462.016836969344, 5497.752601132918, 5880.26496687914, 5889.204957330791, 5897.0, 5927.762889484416, 5938.138969849348, 5814.447627475383, 5817.418258174191, 5885.617434866763, 5946.108083787423, 6022.036474164112, 4728.952710472886, 5540.9168862467095, 5544.889102217933, 5550.4449555044175, 5560.277163968658, 6222.346653601307, 6230.657313847782, 6232.439080482778, 6238.750449982041, 6243.656598887014, 5718.485336319751, 5778.104393818965, 5778.6821724804695, 5813.82558523245, 5913.9112913306335, 6026.216591843032, 6048.60684055535, 6058.303295121117, 6060.939390606038, 6078.969605152034, 5872.7357268923, 5936.37668044849, 5944.227250457413, 5947.9702601486715, 5978.790742323998, 4779.808807647724, 5787.247657804459, 5981.970090149522, 5982.581219314693, 5988.490978266809, 4734.834280800155, 4747.976260118678, 4784.40194975628, 4789.712617242976, 4840.273958906122, 4267.893302667396, 4272.743635381825, 4274.658027357804, 4289.991851914798, 4324.654027677778, 5516.862078448071, 5519.254900588449, 5531.032069387841, 5547.44525547442, 5568.248286481355, 5825.592208545446, 5840.240768700041, 5877.206577112121, 5931.6441013539325, 6009.308929473166, 5431.918521222185, 5527.8894422112135, 5540.722963851791, 5574.804881829116, 5598.44015598445, 4469.642428605704, 5235.319408476874, 5245.239440281214, 5250.684958902478, 5252.44849290819, 6096.466212027279, 6138.204480310071, 6310.305866354789, 6310.337414571588, 6324.9051264231075, 5989.520838332835, 6020.518358531394, 6029.78895738647, 6042.75828966854, 6129.478994285536, 6235.625862448268, 6249.406306400884, 6298.866204083309, 6313.40022697843, 6325.493960483058, 5930.52555795544, 5943.613665111754, 5955.40445955401, 5969.194158788508, 5989.5507836913275, 5698.772049117989, 5816.1857339973285, 5863.706814659165, 5866.2960444746905, 5923.111533269872, 4864.294677271847, 5776.942230577809, 5792.768289268551, 5806.274215723035, 5821.592488525763, 5786.42135786418, 5789.160571716993, 5796.797112101225, 5801.3038435388025, 5812.68030258323, 5506.64206826555, 5618.185363122243, 5630.662160270397, 5655.377908430151, 5664.065429204135, 4843.636727245541, 5818.679972601548, 5829.504492118217, 5871.647701137775, 5876.735546900485, 4745.264484004984, 5519.917201241904, 5572.554195664418, 5693.174489699053, 5709.800156994485], "value": 5395.112470082693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.9700617962925, 513.0841448015291, 513.8381409855895, 518.225253246397, 519.3508114856428, 30860.845695771517, 41052.79473602631, 42298.07826904232, 42326.0, 44339.0, 42875.14249715012, 43087.56912430875, 43444.348334775, 43459.13081738371, 43504.12991740163, 9616.278779091579, 9771.657991970282, 9810.166135878459, 9817.410955342666, 9818.705438836847, 9576.0, 9676.806463870718, 9700.417974921527, 9708.66019689311, 9712.98013708561, 9555.187809036206, 9684.854727179098, 9726.221902247804, 9755.463449510275, 9762.804743905117, 9547.331686781929, 9559.665411710557, 9679.419234845931, 9715.125638692482, 9732.854007189897, 9575.856362154573, 9643.373180743229, 9663.565139568736, 9664.178544823699, 9676.661316853946, 32745.508817367758, 41457.37813932763, 41548.169036619096, 41847.58152418467, 41871.58128418738, 3320.8671653133847, 3463.290025544757, 3485.442329227337, 3590.174259920207, 3699.8520059197867, 31238.21904452384, 31722.682773172204, 32282.0, 32395.83802080998, 32656.020319390456, 3170.5402716605963, 3221.5167724841226, 3227.7256433203206, 3263.7552183586326, 3375.8480868360984, 482443.0, 486157.0, 489222.0, 489284.0, 497925.0, 61532.07701884475, 61911.49929257453, 62097.68951155306, 62187.37812621906, 62260.377396226366, 34910.12724681903, 35565.8221708895, 35604.46593301102, 36550.60364436213, 36597.451038234445, 16288.674226515403, 16401.753973690167, 16514.42199523035, 16520.173991300388, 16529.834701652828, 12572.559960401342, 12679.556215532411, 12710.745785084246, 12721.491140354467, 12726.045546584044, 18993.33523326677, 19429.0, 19439.708404373945, 19449.930253835893, 19464.22143114288, 6339.461145802658, 7584.696612135564, 7606.733764318223, 7686.5787277008685, 7695.961520192475, 835.5738573327646, 981.3768257156614, 982.8574856645889, 993.3096497934011, 1032.0195813976752, 29922.55116173259, 30423.695763042087, 30704.394942805575, 30873.0, 30953.845230774154, 1036.5542816588938, 1049.1606714628267, 1059.9506488576253, 1078.7249251440833, 1085.6742977106837, 15633.0, 15802.89379743407, 15811.0, 15846.366145354288, 16189.352425902833, 557011.0, 559586.0, 561012.0, 562594.0, 567859.0, 58839.41160588425, 59303.11045334324, 59390.703046484494, 59465.0, 59528.404715953155, 1197.6107764976418, 1285.575759999198, 1293.1982171054008, 1343.4961889291515, 1346.562367230654, 28526.288422694706, 29140.56289155622, 29730.256743581584, 30097.548536771526, 30826.92105776287, 51923.0, 52238.21642675439, 52342.738286308326, 52410.0, 52501.47498524966, 497361.0, 498510.0, 499040.0, 499343.0, 500594.0, 26396.604050939637, 26569.0, 26764.788225412296, 26770.19689409321, 26811.865940670952, 46109.53890461053, 47429.28856067231, 48705.26942095942, 48768.0, 48792.512074880215, 38682.80658596689, 39252.42990280357, 39338.016549586486, 40830.387544187455, 40842.0, 39140.60859391483, 39252.214955701296, 39347.409788852616, 40134.598654014255, 40397.59602403938, 33148.00555983324, 33629.83185084059, 33743.0, 37795.0, 38853.41719874261, 29785.0, 34809.955701329, 35014.82492587521, 35293.47059794157, 36162.91511254667, 25595.232143035737, 25621.743782561934, 25835.484546152296, 25837.354066147745, 26181.60727589126], "value": 19670.531477571305, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.65362121234824, 352.2813460540498, 364.75436384746087, 370.5775416025731, 398.6392314954967, 14697.853021469782, 14948.177850218233, 15695.92152039241, 17520.299188032495, 20352.592948141064, 18895.33866314679, 19134.71297930532, 20580.794192058074, 20841.791582084214, 20907.58184836306, 4628.352030715694, 5498.158117030799, 5500.724963751796, 5505.03661859173, 5510.614257002011, 4572.08558288342, 5525.668459892399, 6098.176746139281, 6145.078238264251, 6174.073888916653, 5394.622376433651, 6111.847203819918, 6129.908051379233, 6133.815985520441, 6137.018077107641, 5397.811076612319, 5468.99999999998, 5481.150421684645, 5488.835334939959, 5501.669899806025, 5052.545270925598, 5322.0, 5325.121354976424, 5327.30745003151, 5331.920021199685, 12919.418626161845, 13117.934410327982, 13163.407646655924, 13182.538611148564, 13186.208827470287, 2199.0, 2220.9444763881033, 2322.512272422793, 2586.2887705880844, 2721.18364490652, 9970.551325190312, 10031.648892288807, 10379.84430233547, 10565.049145576859, 15763.527094187193, 1586.4923224568142, 1872.3353209610527, 1875.3061367294051, 1881.67070762616, 1975.8913259770707, 68562.3143768561, 77142.84285735719, 80765.0, 82842.0, 115767.42116289449, 11247.550097996153, 11254.268472549258, 11433.485493152828, 11447.141464390204, 11575.942120289345, 14312.928435357757, 14368.0, 14391.640208994859, 14405.351759170862, 14424.278786060655, 7253.673584688701, 8361.205685459872, 8370.665173393118, 8518.57407129641, 8523.232909038092, 8197.549134797524, 8231.835363292821, 8235.50586964772, 8411.327093832479, 8420.242178203991, 3725.2735716535017, 4482.139911936575, 4488.483824360175, 4527.524609915978, 4553.248713962225, 1853.184598776534, 1905.3140869287045, 1912.1490936533387, 1951.3560525026708, 1954.5113721569608, 845.9957700211583, 858.8840506531664, 912.8128733609594, 978.7063880835863, 1012.0941757127476, 19932.50168745793, 20202.09090590927, 20645.72896981331, 21273.893630532057, 21640.783592164193, 874.9518776467355, 906.4561263242002, 911.3757076402685, 935.2564711054591, 955.6559638530124, 10400.843987340197, 10661.09380702649, 11227.71930701739, 11254.324740515594, 11267.718307042389, 482966.0, 603369.9831500902, 619464.9026754928, 619662.0, 620499.0, 76644.85032724513, 97981.0, 103647.48176259222, 123682.0, 125311.0, 871.7820544863785, 898.0929261445856, 955.6846240740539, 959.2182371367313, 964.4599024546136, 17850.107494624957, 19062.142203600593, 19422.320218792276, 19470.0, 19776.505587359854, 53206.73396632992, 53741.0, 54128.458715412344, 54197.72901135469, 54758.0, 76990.6150469244, 77036.61481692556, 77839.0, 78038.2196178031, 78329.0, 5268.4994925482015, 5341.679499230058, 6277.591956522811, 6645.776798252747, 6739.59562426256, 7596.24037596258, 9403.482808445327, 12560.623181304576, 12864.0, 13230.470781168646, 10381.480925953823, 11069.169812263952, 11517.0, 11574.30554166719, 11617.128715346551, 5921.0, 11037.227394082338, 11056.557737690402, 11378.0, 11393.943030284796, 11200.38397888124, 11283.323000619988, 11434.656960291204, 11812.881871181178, 11905.404729763304, 6960.37356637905, 7425.220351862977, 7471.290227428385, 7575.356094732009, 7733.690652374067, 10731.785364292515, 11121.05471034971, 11213.60752373663, 11618.817225798537, 11655.88344116548], "value": 8991.735065638724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.195366918841, 1480.4744315767903, 1597.5926138834602, 1802.1169626882831, 1868.093974422405, 8419.947506561679, 8918.375713700027, 8922.86615700765, 8937.061608531109, 8951.955240223799, 7795.454318197729, 8048.114707382198, 8055.879161812578, 8216.301614362786, 8693.217610415062, 2116.206422591532, 2151.451379898124, 2258.706368172135, 2349.800266977309, 2359.905603775847, 2358.79950204232, 2365.053978408633, 2367.372646248737, 2368.917087901924, 2373.774491423312, 2317.165820304689, 2339.0643742502966, 2360.6695062691238, 2362.1024010875844, 2371.5019845832394, 2253.9436514087197, 2255.1430456426533, 2269.251147121446, 2347.6595893595504, 2350.576896158691, 2308.8845557722047, 2326.430024643956, 2332.3119679694532, 2339.5905716499547, 2348.9530209395716, 8695.217430431228, 8868.911310886873, 8876.600552975067, 8884.644614215424, 8895.377323587352, 5122.359705036871, 5294.7617357219015, 5294.867628309323, 5297.841064768063, 5300.0, 3412.2322477442626, 3557.3418917500344, 3622.5290712207243, 3626.6373362663785, 3631.346357655621, 1016.8627235323211, 1030.6392762533128, 1051.0645525482328, 1070.0743856564093, 1074.51646758958, 11655.067594592412, 11734.94132529332, 11752.001079908217, 11777.528898844035, 11782.88217117835, 4438.845900065941, 4558.9772051139535, 4758.500357462417, 4766.332713420124, 4768.6661933665, 9886.456244906456, 9902.851457228147, 9909.108180263811, 9913.206943444507, 9939.850902236472, 5299.33758280215, 5303.4696530346655, 5309.5752339812725, 5314.176302673091, 5368.758405871745, 4731.503192164842, 4807.351007613927, 4861.978984413313, 4869.440014398389, 4880.121578115903, 3567.4470457079196, 3704.1294146456407, 3709.7774133552075, 3757.1922036762226, 3826.9808650957125, 1042.1506472225112, 1251.217988757027, 1257.251935098615, 1258.383392137846, 1273.331500961984, 618.9071639254058, 775.9418043646749, 891.8662200669952, 902.4089221559889, 954.5513608603945, 5766.279215098113, 5813.651180929158, 5953.404659534012, 6013.9699301503215, 6181.412765787243, 900.6802585082332, 955.6225291010012, 967.1730670276953, 987.7481242283171, 1019.8113349030453, 3794.9810250948567, 3841.7310788244554, 3874.9806250968563, 3934.881953541398, 3964.1278918637854, 10621.2034097443, 10667.733306667395, 10695.358278503314, 10899.073578745736, 10940.617078402218, 10773.0, 10833.67498975032, 10842.783144337069, 10868.565257389615, 10899.346039237671, 7802.609869506502, 8080.676772929134, 8100.18998100197, 8278.0, 8291.419600628018, 5924.407559244041, 6007.729652165575, 6019.548533860066, 6045.727942242697, 6175.722092505938, 9896.158826499828, 9993.900060999296, 10044.146247569039, 10186.745331366776, 10217.846732298873, 9919.702408927744, 10224.744381390525, 10227.335223210468, 10285.0, 10404.814988852124, 7227.241139680468, 7453.552786832807, 7570.318671319607, 7627.580483073484, 7650.846983060196, 7448.441366897396, 7702.768916932501, 7718.57547834852, 8229.629666664894, 8314.87527687073, 6877.764726464019, 7388.1503627083575, 7459.36595389398, 7547.207543207884, 7572.20491848348, 7235.891461627974, 7313.232110628307, 7327.2672732726305, 7384.852302953804, 7398.852022959403, 6857.485688573277, 6977.197622273504, 6980.197277312971, 6983.44132469391, 6989.231184569591, 4870.889691007882, 4876.90246195067, 4900.803967841389, 4995.675281106716, 5112.6165537585575, 4748.9050218994735, 5006.924896126634, 5073.492650734897, 5081.23781432788, 5166.483351664803], "value": 4555.549761159617, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.46061697658524, 297.7722042637384, 306.8557777844414, 311.5638106650689, 315.4038866542234, 4173.707840451166, 4900.289458028588, 4961.5286547777905, 5113.923291150626, 5229.529342359187, 5047.873803154923, 5096.79612815487, 5182.253405694978, 5215.757224393509, 5262.2632831403635, 3770.396736522157, 4017.3973903914502, 4032.5967403259733, 4036.5559788423398, 4040.030392705759, 3607.9098022549383, 3772.4718539404507, 4051.210014047262, 4052.837886484537, 4073.226087043467, 3367.4948757686298, 3933.7743050698436, 3974.463447434588, 3992.7223288547675, 4011.3352958522323, 3288.671132886704, 3978.2839088963974, 3983.0, 3988.78061706606, 3999.5200575931076, 3168.30297334586, 3213.9467505869516, 3460.9790111917046, 3515.91006787894, 3519.964800351989, 4423.557644235583, 4692.648051396159, 4830.6135509159185, 5020.799168033274, 5089.0, 4259.616634502879, 4388.275934470808, 4493.910121797546, 4496.865094047183, 4510.233260345716, 4742.668013239075, 5022.844745708471, 5201.505856943584, 5500.339959204881, 5501.9174712379345, 3351.731861451078, 3592.2995015971896, 3702.8889133326043, 3708.7218458615444, 3770.0, 4718.646101542364, 5692.7153642318135, 5748.396418376052, 5751.009475072939, 5778.971105144447, 3473.1838018065732, 3711.6473934976134, 3766.2844059629133, 3820.6561409472724, 3838.673712734393, 3563.592381009487, 3571.8571257149424, 3868.4777555030273, 3882.3011857865854, 3885.4171874218528, 4449.733016018984, 4464.866054018385, 4468.553144685506, 4483.551644835556, 4512.796924138422, 4769.523047695272, 5488.890222195534, 5512.0, 5548.029094908375, 5578.30271216098, 1247.4822948476462, 1281.7180220351509, 1282.5190553542423, 1294.152330223705, 1323.1597935310954, 708.8429868907988, 722.4220623501283, 814.6822739131743, 826.3430572694722, 830.8462934357163, 3581.4627805828814, 3670.5595328560744, 4015.257177422186, 4353.32523458858, 4381.9123617527475, 4215.557366476537, 4710.481846996828, 4736.0, 4764.833230836974, 4806.49531799156, 3826.5025546678753, 3966.4050392440786, 4323.567643235714, 4336.978315108404, 4348.0, 2244.1696572268365, 2300.9309720708407, 2301.2405906050963, 2429.4047958250344, 2495.7645965246957, 4145.7719825409895, 4316.956830431718, 4675.719456832533, 4886.877828054327, 4917.852464426073, 3897.512810898638, 4384.539623339503, 4748.50422117032, 4813.229883218738, 4813.687110337817, 4011.659008984269, 4281.293586558245, 4429.490608580055, 4851.466338702739, 4891.241857512091, 3889.805509724559, 4619.653525985632, 4654.18551753435, 4699.76501174933, 4725.551072648231, 4094.1924010670364, 4101.651359634465, 4138.193052354762, 4390.868273951786, 4623.953760462352, 4021.537523184871, 4245.95754042468, 4369.84199187222, 4530.818767249273, 4873.975630121827, 2722.414680843628, 3167.8416079195486, 3176.698213669698, 3302.1579497228054, 3305.3719793239206, 3925.666318362971, 4346.391835021062, 4415.911681766411, 4702.811887524461, 4767.61859051282, 3691.784929042553, 4557.840475583339, 4567.543245675406, 4601.585857272861, 4665.4634717007975, 4132.979335103426, 4412.338149277634, 4560.703554268962, 4588.678792484494, 4588.977055114703, 3981.144054028398, 4004.599540045972, 4119.958800411958, 4195.035141917315, 4505.139236584727, 4481.887952801206, 4714.81140754366, 5389.407165211902, 5403.649087728068, 5415.891682166413, 4897.608191344612, 5341.4925582069645, 5386.165144402624, 5397.78408863641, 5404.891902161856], "value": 3660.4396772836903, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.1024323501066, 695.749530169139, 708.9255628159043, 747.3175753256521, 795.5346122518326, 15070.924645376772, 15596.986195897287, 15605.375784968615, 15666.530004099866, 15692.52922412328, 13530.008647449002, 13538.661533461669, 13545.322733863317, 13548.916086713063, 13649.044566880322, 610.4902406490586, 666.1939053744975, 691.7475121580612, 691.9723211071577, 843.4348986179275, 838.6351936907465, 847.0470720439506, 854.850401179791, 854.8504011797942, 861.1431625532604, 908.995455022724, 911.5305617606938, 912.9726108216764, 913.4427998920653, 916.2852974679761, 704.1866644026157, 729.3472342253706, 901.9458832470007, 904.9140331668481, 905.4250550900193, 536.9758360873731, 538.5987439357704, 538.8518157506678, 539.7436217796554, 637.1430426076919, 14402.423903043866, 14900.105993640416, 14908.0, 14948.252587370587, 14959.252037398195, 13243.86756132436, 13528.25594592297, 13599.864001359958, 13821.447142114303, 13968.0, 12363.381830908418, 12424.641673653474, 12482.251064936043, 12538.749225015448, 12961.351932403437, 4470.307102399133, 4488.259437192859, 4562.973331000531, 4686.5782079613, 4693.319468677057, 102678.0, 119003.4049829754, 120057.0, 123774.0, 123853.38073309665, 10679.626213082505, 10767.407792571326, 10793.568257269779, 10873.347599144077, 10947.069499092666, 21459.141634334763, 21472.24847130343, 21489.78510214909, 21541.67687484689, 21576.0, 7612.276833700789, 7624.0, 7799.298063174341, 7906.209379062047, 8032.558209298428, 4250.978745106255, 4267.295896177096, 4308.246056940023, 4355.869323920288, 4447.911041779146, 3410.1474631342167, 3524.242287908112, 3530.770499917497, 3533.4876442915634, 3534.2401383702627, 522.1343834797868, 629.0532748213909, 636.4431122767578, 637.7799659117597, 638.3170008091298, 491.5354989534855, 560.4352548492586, 598.5750117416683, 617.5677026081761, 620.1287191495956, 8704.695335663222, 8812.0, 8820.029796722356, 8826.823463530693, 9200.495924555755, 568.7525926222106, 576.2393640394722, 605.4732382826969, 609.8597322615823, 642.4057746584391, 4112.506499220053, 4300.204462174508, 4370.38814565961, 4450.621697155713, 4468.888277793016, 157833.0, 160428.19785900996, 163785.0, 169593.0, 175799.0, 38133.0, 66338.0, 101590.0, 126536.36731816283, 132978.0, 77785.2221477778, 89212.0, 97892.51053744685, 99553.0, 107496.8500629983, 9501.952490237505, 9662.661806836726, 9911.603535858485, 9922.751931201778, 9966.352187107816, 53787.6553086176, 55046.0, 55289.0, 56338.0, 64158.679206603665, 61564.0, 62596.374036259054, 67401.0, 78375.0, 81615.0, 10845.620403285848, 10933.398663073607, 11249.0, 11358.318500889642, 11496.195266331277, 14151.43394264218, 14477.203753793221, 14708.485203018272, 15128.697426051198, 15442.30509627092, 13253.933730331672, 13983.510577129751, 14024.158550487004, 14602.269886505845, 14766.926165369105, 11384.829227561759, 11453.427328633701, 12175.443306041687, 13058.34708264564, 13651.11267767592, 13706.0, 13831.515896943962, 13833.239171845646, 13931.233782141675, 14125.929370353082, 9807.509624518603, 11166.49750761234, 11491.942540287246, 11574.321723349898, 12147.817782733442, 10871.130309575374, 11449.771004580029, 11543.88456115428, 11710.4730287139, 11738.178327516991], "value": 7522.3408100699835, "unit": "score"}], "name": "dromaeo_css", "value": 7020.31218844621, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 113.0, 111.0, 112.0, 114.0, 114.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 112.0, 111.0, 150.0, 114.0, 112.0, 114.0, 110.0, 143.0, 113.0], "value": 123.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 182.0, 184.0, 181.0, 188.0, 182.0, 181.0, 213.0, 198.0], "value": 187.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 58.0, 86.0, 61.0, 59.0, 61.0, 81.0, 110.0, 83.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 92.0, 71.0, 69.0, 71.0, 117.0, 53.0, 55.0, 74.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 85.0, 87.0, 84.0, 89.0, 85.0, 87.0, 87.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 83.0, 83.0, 84.0, 82.0, 85.0, 83.0, 84.0, 86.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 53.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 64.0, 74.0, 74.0, 69.0, 69.0, 73.0, 69.0, 71.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 86.0, 89.0, 85.0, 86.0, 84.0, 86.0, 90.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 143.0, 138.0, 145.0, 146.0, 142.0, 178.0, 141.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 172.0, 170.0, 171.0, 152.0, 194.0, 229.0, 171.0, 171.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 66.0, 67.0, 66.0, 68.0, 67.0, 68.0, 68.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1439.2000000000003, "alertThreshold": 2.0}]} 21:53:24 INFO - Return code: 0 21:53:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:53:24 INFO - # TBPL SUCCESS # 21:53:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:53:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:53:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:53:24 INFO - 2016-10-12 21:53:24.632 screenresolution[1662:10166] starting screenresolution argv=screenresolution get 21:53:24 INFO - 2016-10-12 21:53:24.635 screenresolution[1662:10166] Display 0: 1600x1200x32@60 21:53:24 INFO - 2016-10-12 21:53:24.641 screenresolution[1663:10169] starting screenresolution argv=screenresolution list 21:53:24 INFO - Available Modes on Display 0 21:53:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:53:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:53:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:53:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:53:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:53:24 INFO - Intel Iris: 21:53:24 INFO - Chipset Model: Intel Iris 21:53:24 INFO - Type: GPU 21:53:24 INFO - Bus: Built-In 21:53:24 INFO - VRAM (Dynamic, Max): 1536 MB 21:53:24 INFO - Vendor: Intel (0x8086) 21:53:24 INFO - Device ID: 0x0a2e 21:53:24 INFO - Revision ID: 0x0009 21:53:24 INFO - Displays: 21:53:24 INFO - Display: 21:53:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:53:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:53:24 INFO - Display Serial Number: 1600x1200 60 21:53:24 INFO - Main Display: Yes 21:53:24 INFO - Mirror: Off 21:53:24 INFO - Online: Yes 21:53:24 INFO - Rotation: Supported 21:53:24 INFO - Return code: 0 21:53:24 INFO - Running post-action listener: _resource_record_post_action 21:53:24 INFO - [mozharness: 2016-10-13 04:53:24.885309Z] Finished run-tests step (success) 21:53:24 INFO - Running post-run listener: _resource_record_post_run 21:53:24 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37217280; Write bytes: 710278656; Read time: 240; Write time: 1982 21:53:24 INFO - TinderboxPrint: CPU usage
53.7% 21:53:24 INFO - TinderboxPrint: I/O read bytes / time
37,217,280 / 240 21:53:24 INFO - TinderboxPrint: I/O write bytes / time
710,278,656 / 1,982 21:53:24 INFO - TinderboxPrint: CPU idle
2,245.8 (46.3%) 21:53:24 INFO - TinderboxPrint: CPU system
970.9 (20.0%) 21:53:24 INFO - TinderboxPrint: CPU user
1,633.0 (33.7%) 21:53:24 INFO - TinderboxPrint: Swap in / out
444,485,632 / 0 21:53:24 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393378304; Write bytes: 388052992; Read time: 29138; Write time: 787 21:53:24 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36262912; Write bytes: 299918848; Read time: 228; Write time: 1138 21:53:25 INFO - Running post-run listener: _upload_blobber_files 21:53:25 INFO - Blob upload gear active. 21:53:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:53:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:53:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:53:25 INFO - (blobuploader) - INFO - Open directory for files ... 21:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:53:26 INFO - (blobuploader) - INFO - Done attempting. 21:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:53:27 INFO - (blobuploader) - INFO - Done attempting. 21:53:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:53:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:53:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:53:30 INFO - (blobuploader) - INFO - Done attempting. 21:53:30 INFO - (blobuploader) - INFO - Iteration through files over. 21:53:30 INFO - Return code: 0 21:53:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:53:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:53:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a9af7c08819d585fdce15dbbc6d0e49673f8b9e1cff77c18701417f015af42643e148ef17de89249706b801e09bb895b579e3c6713f0920d104ba1cb9790d9fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6aa9ed1b6e46e40987f8553e90be5a94519ad92416b737b38c762b0ab543ef21fac7a74d9654af562b42dc2007f3ea5146b07eab6edaf1c1dee62649b66f56b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e94c2ee23d8271f64ba50b3d19ed6485fd0a665cf2cbd8edb053669ffa6e0702938634a8da37d9ea2ab32f755d3aa4fa3d41f14d545abebaff6afe6480a2e58"} 21:53:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:53:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:53:30 INFO - Contents: 21:53:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a9af7c08819d585fdce15dbbc6d0e49673f8b9e1cff77c18701417f015af42643e148ef17de89249706b801e09bb895b579e3c6713f0920d104ba1cb9790d9fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6aa9ed1b6e46e40987f8553e90be5a94519ad92416b737b38c762b0ab543ef21fac7a74d9654af562b42dc2007f3ea5146b07eab6edaf1c1dee62649b66f56b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e94c2ee23d8271f64ba50b3d19ed6485fd0a665cf2cbd8edb053669ffa6e0702938634a8da37d9ea2ab32f755d3aa4fa3d41f14d545abebaff6afe6480a2e58"} 21:53:30 INFO - Running post-run listener: copy_logs_to_upload_dir 21:53:30 INFO - Copying logs to upload dir... 21:53:30 INFO - mkdir: /builds/slave/test/build/upload/logs 21:53:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.230625 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-12 21:53:30.504358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 21:53:30.507927) ========= 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.fhz2JKrU5j/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.2jrslD9fLS/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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/a9af7c08819d585fdce15dbbc6d0e49673f8b9e1cff77c18701417f015af42643e148ef17de89249706b801e09bb895b579e3c6713f0920d104ba1cb9790d9fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6aa9ed1b6e46e40987f8553e90be5a94519ad92416b737b38c762b0ab543ef21fac7a74d9654af562b42dc2007f3ea5146b07eab6edaf1c1dee62649b66f56b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e94c2ee23d8271f64ba50b3d19ed6485fd0a665cf2cbd8edb053669ffa6e0702938634a8da37d9ea2ab32f755d3aa4fa3d41f14d545abebaff6afe6480a2e58"} build_url:https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://queue.taskcluster.net/v1/task/FrnII47XQrymci-Redn8yg/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/a9af7c08819d585fdce15dbbc6d0e49673f8b9e1cff77c18701417f015af42643e148ef17de89249706b801e09bb895b579e3c6713f0920d104ba1cb9790d9fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6aa9ed1b6e46e40987f8553e90be5a94519ad92416b737b38c762b0ab543ef21fac7a74d9654af562b42dc2007f3ea5146b07eab6edaf1c1dee62649b66f56b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9e94c2ee23d8271f64ba50b3d19ed6485fd0a665cf2cbd8edb053669ffa6e0702938634a8da37d9ea2ab32f755d3aa4fa3d41f14d545abebaff6afe6480a2e58"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 21:53:30.541447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 21:53:30.541791) ========= 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.fhz2JKrU5j/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.2jrslD9fLS/Listeners TMPDIR=/var/folders/d3/5t0h_zln4kq7v984ly1b_brh00000w/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.005144 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 21:53:30.590429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 21:53:30.590752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 21:53:30.591086) ========= ========= Total master_lag: 0.18 =========