builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0385 starttime: 1479448751.8 results: success (0) buildid: 20161117192228 builduid: 5b4237af75434562aaea6e792075d428 revision: 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:11.796887) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:11.797327) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:11.797646) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:11.821212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:11.821622) ========= 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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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-11-17 21:59:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 50.7M=0s 2016-11-17 21:59:11 (50.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123889 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:11.967449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:11.967771) ========= 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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.019695 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:12.015109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 21:59:12.015456) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qOaRzlfnRf/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.Xt5VwePfyS/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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-11-17 21:59:12,099 truncating revision to first 12 chars 2016-11-17 21:59:12,099 Setting DEBUG logging. 2016-11-17 21:59:12,099 attempt 1/10 2016-11-17 21:59:12,099 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8e476f8bd52d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 21:59:13,021 unpacking tar archive at: mozilla-central-8e476f8bd52d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.351995 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 21:59:13.389130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:13.389428) ========= script_repo_revision: 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:13.389884) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:13.390237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 21:59:13.408447) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-17 21:59:13.408726) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qOaRzlfnRf/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.Xt5VwePfyS/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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:59:13 INFO - MultiFileLogger online at 20161117 21:59:13 in /builds/slave/test 21:59:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:59:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:59:13 INFO - {'append_to_log': False, 21:59:13 INFO - 'base_work_dir': '/builds/slave/test', 21:59:13 INFO - 'blob_upload_branch': 'Firefox', 21:59:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:59:13 INFO - 'branch': 'Firefox', 21:59:13 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:13 INFO - 'config_files': ('talos/mac_config.py',), 21:59:13 INFO - 'default_actions': ('clobber', 21:59:13 INFO - 'read-buildbot-config', 21:59:13 INFO - 'download-and-extract', 21:59:13 INFO - 'populate-webroot', 21:59:13 INFO - 'create-virtualenv', 21:59:13 INFO - 'install', 21:59:13 INFO - 'run-tests'), 21:59:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:13 INFO - 'download_minidump_stackwalk': True, 21:59:13 INFO - 'download_symbols': 'ondemand', 21:59:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:13 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:13 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:13 INFO - 'installer_path': 'installer.exe', 21:59:13 INFO - 'log_level': 'info', 21:59:13 INFO - 'log_name': 'talos', 21:59:13 INFO - 'log_to_console': True, 21:59:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:59:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:59:13 INFO - 'opt_config_files': (), 21:59:13 INFO - 'pip_index': False, 21:59:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:59:13 INFO - 'cmd': ('bash', 21:59:13 INFO - '-c', 21:59:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:59:13 INFO - 'enabled': True, 21:59:13 INFO - 'halt_on_failure': False, 21:59:13 INFO - 'name': 'check_screen_resolution'},), 21:59:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:59:13 INFO - 'cmd': ('bash', 21:59:13 INFO - '-c', 21:59:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:59:13 INFO - 'enabled': True, 21:59:13 INFO - 'halt_on_failure': False, 21:59:13 INFO - 'name': 'check_screen_resolution'},), 21:59:13 INFO - 'run_cmd_checks_enabled': True, 21:59:13 INFO - 'sps_profile': False, 21:59:13 INFO - 'sps_profile_interval': 0, 21:59:13 INFO - 'suite': 'dromaeojs', 21:59:13 INFO - 'system_bits': '32', 21:59:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:13 INFO - 'title': 't-yosemite-r7-0385', 21:59:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:13 INFO - 'use_talos_json': True, 21:59:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:59:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:13 INFO - 'work_dir': 'build'} 21:59:13 INFO - [mozharness: 2016-11-18 05:59:13.613749Z] Running clobber step. 21:59:13 INFO - Running pre-action listener: _resource_record_pre_action 21:59:13 INFO - Running main action method: clobber 21:59:13 INFO - rmtree: /builds/slave/test/build 21:59:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:59:15 INFO - Running post-action listener: _resource_record_post_action 21:59:15 INFO - [mozharness: 2016-11-18 05:59:15.120102Z] Finished clobber step (success) 21:59:15 INFO - [mozharness: 2016-11-18 05:59:15.120281Z] Running read-buildbot-config step. 21:59:15 INFO - Running pre-action listener: _resource_record_pre_action 21:59:15 INFO - Running main action method: read_buildbot_config 21:59:15 INFO - Using buildbot properties: 21:59:15 INFO - { 21:59:15 INFO - "project": "", 21:59:15 INFO - "product": "firefox", 21:59:15 INFO - "script_repo_revision": "production", 21:59:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:59:15 INFO - "repository": "", 21:59:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:59:15 INFO - "buildid": "20161117192228", 21:59:15 INFO - "pgo_build": "False", 21:59:15 INFO - "basedir": "/builds/slave/test", 21:59:15 INFO - "buildnumber": 21, 21:59:15 INFO - "slavename": "t-yosemite-r7-0385", 21:59:15 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 21:59:15 INFO - "platform": "yosemite_r7", 21:59:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:59:15 INFO - "branch": "mozilla-central", 21:59:15 INFO - "repo_path": "mozilla-central", 21:59:15 INFO - "revision": "8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a", 21:59:15 INFO - "stage_platform": "macosx64", 21:59:15 INFO - "builduid": "5b4237af75434562aaea6e792075d428", 21:59:15 INFO - "slavebuilddir": "test" 21:59:15 INFO - } 21:59:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 21:59:15 INFO - Running post-action listener: _resource_record_post_action 21:59:15 INFO - [mozharness: 2016-11-18 05:59:15.124451Z] Finished read-buildbot-config step (success) 21:59:15 INFO - [mozharness: 2016-11-18 05:59:15.124564Z] Running download-and-extract step. 21:59:15 INFO - Running pre-action listener: _resource_record_pre_action 21:59:15 INFO - Running main action method: download_and_extract 21:59:15 INFO - mkdir: /builds/slave/test/build/tests 21:59:15 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:59:15 INFO - trying https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 21:59:15 INFO - Downloading https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 21:59:16 INFO - Downloaded 1199 bytes. 21:59:16 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:59:16 INFO - Using the following test package requirements: 21:59:16 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:59:16 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:59:16 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 21:59:16 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:59:16 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 21:59:16 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:59:16 INFO - u'jsshell-mac.zip'], 21:59:16 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:59:16 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 21:59:16 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:59:16 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:59:16 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 21:59:16 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:59:16 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 21:59:16 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:59:16 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 21:59:16 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:59:16 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 21:59:16 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:59:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:59:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:59:16 INFO - Fetch https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:59:17 INFO - Http code: 200 21:59:17 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 21:59:17 INFO - x-amz-cf-id: WlIIAKlCAWf2dJjeR28zDtzmnfbQylckm1Rgk4qkLwDW5fNd7BYGHw== 21:59:17 INFO - x-amz-version-id: 0Itmr8nyfHcUPgnc52lUgsrvXECM.EjQ 21:59:17 INFO - Expected file size: 16223085 21:59:17 INFO - Obtained file size: 16223085 21:59:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:59:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:59:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:59:24 INFO - Fetch https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:59:24 INFO - Http code: 200 21:59:24 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 21:59:24 INFO - x-amz-cf-id: D5cjweqn78X8daEJd3zRZaQ2MDEJpvWrQryFE94mN1FrNwLx95D51g== 21:59:24 INFO - x-amz-version-id: 0Itmr8nyfHcUPgnc52lUgsrvXECM.EjQ 21:59:25 INFO - Expected file size: 16223085 21:59:25 INFO - Obtained file size: 16223085 21:59:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 21:59:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:59:31 INFO - Fetch https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 21:59:31 INFO - Http code: 200 21:59:31 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 21:59:31 INFO - x-amz-cf-id: xf4XVmyfd1CdQJjbU9ao5eXPJwksxhQaXjuwQ9dPPnWPuN9BAAXDkQ== 21:59:31 INFO - x-amz-version-id: akYFSKLF1P1cmSN111zHEoJTcRt3gLS5 21:59:32 INFO - Expected file size: 14409392 21:59:32 INFO - Obtained file size: 14409392 21:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:32 INFO - trying https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:59:32 INFO - Downloading https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 21:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 21:59:35 INFO - Downloaded 107370470 bytes. 21:59:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:59:35 INFO - mkdir: /builds/slave/test/properties 21:59:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:59:35 INFO - Writing to file /builds/slave/test/properties/build_url 21:59:35 INFO - Contents: 21:59:35 INFO - build_url:https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:59:35 INFO - Running post-action listener: _resource_record_post_action 21:59:35 INFO - Running post-action listener: set_extra_try_arguments 21:59:35 INFO - [mozharness: 2016-11-18 05:59:35.920120Z] Finished download-and-extract step (success) 21:59:35 INFO - [mozharness: 2016-11-18 05:59:35.920244Z] Running populate-webroot step. 21:59:35 INFO - Running pre-action listener: _resource_record_pre_action 21:59:35 INFO - Running main action method: populate_webroot 21:59:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:35 INFO - '--tppagecycles', 21:59:35 INFO - '7'], 21:59:35 INFO - 'tests': ['tsvgm']}}, 21:59:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:59:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:59:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:59:35 INFO - 'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:59:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:59:35 INFO - 'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['damp', 'tps']}, 21:59:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:59:35 INFO - 'tests': ['damp', 'tps']}, 21:59:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['dromaeo_dom']}, 21:59:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['basic_compositor_video']}, 21:59:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:59:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['a11yr', 21:59:35 INFO - 'ts_paint', 21:59:35 INFO - 'tpaint', 21:59:35 INFO - 'sessionrestore', 21:59:35 INFO - 'sessionrestore_no_auto_restore', 21:59:35 INFO - 'tabpaint']}, 21:59:35 INFO - 'other-e10s': {'tests': ['a11yr', 21:59:35 INFO - 'ts_paint', 21:59:35 INFO - 'tpaint', 21:59:35 INFO - 'sessionrestore', 21:59:35 INFO - 'sessionrestore_no_auto_restore', 21:59:35 INFO - 'tabpaint']}, 21:59:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:59:35 INFO - 'ts_paint', 21:59:35 INFO - 'tpaint', 21:59:35 INFO - 'sessionrestore', 21:59:35 INFO - 'sessionrestore_no_auto_restore', 21:59:35 INFO - 'tabpaint']}, 21:59:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:59:35 INFO - 'ts_paint', 21:59:35 INFO - 'tpaint', 21:59:35 INFO - 'sessionrestore', 21:59:35 INFO - 'sessionrestore_no_auto_restore', 21:59:35 INFO - 'tabpaint']}, 21:59:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['a11yr', 21:59:35 INFO - 'ts_paint', 21:59:35 INFO - 'tpaint', 21:59:35 INFO - 'sessionrestore', 21:59:35 INFO - 'sessionrestore_no_auto_restore', 21:59:35 INFO - 'tabpaint']}, 21:59:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['a11yr', 21:59:35 INFO - 'ts_paint', 21:59:35 INFO - 'tpaint', 21:59:35 INFO - 'sessionrestore', 21:59:35 INFO - 'sessionrestore_no_auto_restore', 21:59:35 INFO - 'tabpaint']}, 21:59:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['tsvgx', 21:59:35 INFO - 'tsvgr_opacity', 21:59:35 INFO - 'tart', 21:59:35 INFO - 'tscrollx', 21:59:35 INFO - 'cart']}, 21:59:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:59:35 INFO - 'tsvgr_opacity', 21:59:35 INFO - 'tart', 21:59:35 INFO - 'tscrollx', 21:59:35 INFO - 'cart']}, 21:59:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:59:35 INFO - 'talos_options': ['--disable-e10s'], 21:59:35 INFO - 'tests': ['tp5o']}, 21:59:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:59:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:59:35 INFO - 'talos_options': ['--disable-e10s', 21:59:35 INFO - '--xperf_path', 21:59:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:35 INFO - 'tests': ['tp5n']}, 21:59:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:59:35 INFO - 'talos_options': ['--xperf_path', 21:59:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:35 INFO - 'tests': ['tp5n']}}, 21:59:35 INFO - 'talos.zip': {'path': '', 21:59:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:35 INFO - Running post-action listener: _resource_record_post_action 21:59:35 INFO - [mozharness: 2016-11-18 05:59:35.938621Z] Finished populate-webroot step (success) 21:59:35 INFO - [mozharness: 2016-11-18 05:59:35.938718Z] Running create-virtualenv step. 21:59:35 INFO - Running pre-action listener: _resource_record_pre_action 21:59:35 INFO - Running main action method: create_virtualenv 21:59:35 INFO - Creating virtualenv /builds/slave/test/build/venv 21:59:35 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:59:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:59:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:36 INFO - Using real prefix '/tools/python27' 21:59:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:59:36 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:39 INFO - Installing pip.................done. 21:59:39 INFO - Return code: 0 21:59:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:59:39 INFO - Reading from file tmpfile_stdout 21:59:39 INFO - Output received: 21:59:39 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:59:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:59:39 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:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:39 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:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:39 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 0x100d173f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb393d9f6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, '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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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:59:39 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:59:39 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:59:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 21:59:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:39 INFO - 'HOME': '/Users/cltbld', 21:59:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:39 INFO - 'LOGNAME': 'cltbld', 21:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:39 INFO - 'MOZ_NO_REMOTE': '1', 21:59:39 INFO - 'NO_EM_RESTART': '1', 21:59:39 INFO - 'PAGER': '/bin/cat', 21:59:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:39 INFO - 'PWD': '/builds/slave/test', 21:59:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:39 INFO - 'SHELL': '/bin/bash', 21:59:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 21:59:39 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 21:59:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:39 INFO - 'USER': 'cltbld', 21:59:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:39 INFO - 'XPC_FLAGS': '0x0', 21:59:39 INFO - 'XPC_SERVICE_NAME': '0', 21:59:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:40 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:59:40 INFO - Cleaning up... 21:59:40 INFO - Return code: 0 21:59:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:59:40 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:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:40 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:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:40 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 0x100d173f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb393d9f6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, '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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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:59:40 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:59:40 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:59:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 21:59:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:40 INFO - 'HOME': '/Users/cltbld', 21:59:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:40 INFO - 'LOGNAME': 'cltbld', 21:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:40 INFO - 'MOZ_NO_REMOTE': '1', 21:59:40 INFO - 'NO_EM_RESTART': '1', 21:59:40 INFO - 'PAGER': '/bin/cat', 21:59:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:40 INFO - 'PWD': '/builds/slave/test', 21:59:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:40 INFO - 'SHELL': '/bin/bash', 21:59:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 21:59:40 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 21:59:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:40 INFO - 'USER': 'cltbld', 21:59:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:40 INFO - 'XPC_FLAGS': '0x0', 21:59:40 INFO - 'XPC_SERVICE_NAME': '0', 21:59:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:40 INFO - Downloading/unpacking psutil>=3.1.1 21:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:43 INFO - Installing collected packages: psutil 21:59:43 INFO - Running setup.py install for psutil 21:59:43 INFO - building 'psutil._psutil_osx' extension 21:59:43 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:59:44 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:59:44 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:59:44 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:59:44 INFO - building 'psutil._psutil_posix' extension 21:59:44 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:59:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:59:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:59:44 INFO - ^ 21:59:44 INFO - 1 warning generated. 21:59:44 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:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:44 INFO - Successfully installed psutil 21:59:44 INFO - Cleaning up... 21:59:44 INFO - Return code: 0 21:59:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:59: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:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100d173f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb393d9f6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, '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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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:59: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:59: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 mozsystemmonitor==0.3 21:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 21:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:44 INFO - 'HOME': '/Users/cltbld', 21:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:44 INFO - 'LOGNAME': 'cltbld', 21:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:44 INFO - 'MOZ_NO_REMOTE': '1', 21:59:44 INFO - 'NO_EM_RESTART': '1', 21:59:44 INFO - 'PAGER': '/bin/cat', 21:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:44 INFO - 'PWD': '/builds/slave/test', 21:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:44 INFO - 'SHELL': '/bin/bash', 21:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 21:59:44 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 21:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:44 INFO - 'USER': 'cltbld', 21:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:44 INFO - 'XPC_FLAGS': '0x0', 21:59:44 INFO - 'XPC_SERVICE_NAME': '0', 21:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:59:45 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:59:45 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:59:45 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:59:45 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:59:45 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:59:45 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:59:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:59:47 INFO - Installing collected packages: mozsystemmonitor 21:59:47 INFO - Running setup.py install for mozsystemmonitor 21:59:47 INFO - Successfully installed mozsystemmonitor 21:59:47 INFO - Cleaning up... 21:59:47 INFO - Return code: 0 21:59:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100d173f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb393d9f6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, '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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 21:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:47 INFO - 'HOME': '/Users/cltbld', 21:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:47 INFO - 'LOGNAME': 'cltbld', 21:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:47 INFO - 'MOZ_NO_REMOTE': '1', 21:59:47 INFO - 'NO_EM_RESTART': '1', 21:59:47 INFO - 'PAGER': '/bin/cat', 21:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:47 INFO - 'PWD': '/builds/slave/test', 21:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:47 INFO - 'SHELL': '/bin/bash', 21:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 21:59:47 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 21:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:47 INFO - 'USER': 'cltbld', 21:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:47 INFO - 'XPC_FLAGS': '0x0', 21:59:47 INFO - 'XPC_SERVICE_NAME': '0', 21:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:48 INFO - Downloading/unpacking jsonschema==2.5.1 21:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:59:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:50 INFO - Downloading functools32-3.2.3-2.tar.gz 21:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:59:51 INFO - warning: no files found matching '*.txt' 21:59:51 INFO - no previously-included directories found matching 'build' 21:59:51 INFO - no previously-included directories found matching 'dist' 21:59:51 INFO - no previously-included directories found matching '.git*' 21:59:51 INFO - Installing collected packages: jsonschema, functools32 21:59:51 INFO - Running setup.py install for functools32 21:59:51 INFO - warning: no files found matching '*.txt' 21:59:51 INFO - no previously-included directories found matching 'build' 21:59:51 INFO - no previously-included directories found matching 'dist' 21:59:51 INFO - no previously-included directories found matching '.git*' 21:59:51 INFO - Successfully installed jsonschema functools32 21:59:51 INFO - Cleaning up... 21:59:51 INFO - Return code: 0 21:59:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100d173f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb393d9f6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, '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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 21:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:51 INFO - 'HOME': '/Users/cltbld', 21:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:51 INFO - 'LOGNAME': 'cltbld', 21:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:51 INFO - 'MOZ_NO_REMOTE': '1', 21:59:51 INFO - 'NO_EM_RESTART': '1', 21:59:51 INFO - 'PAGER': '/bin/cat', 21:59:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:51 INFO - 'PWD': '/builds/slave/test', 21:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:51 INFO - 'SHELL': '/bin/bash', 21:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 21:59:51 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 21:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:51 INFO - 'USER': 'cltbld', 21:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:51 INFO - 'XPC_FLAGS': '0x0', 21:59:51 INFO - 'XPC_SERVICE_NAME': '0', 21:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:59:51 INFO - Cleaning up... 21:59:51 INFO - Return code: 0 21:59:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100d173f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb393d9f6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, '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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 21:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:51 INFO - 'HOME': '/Users/cltbld', 21:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:51 INFO - 'LOGNAME': 'cltbld', 21:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:51 INFO - 'MOZ_NO_REMOTE': '1', 21:59:51 INFO - 'NO_EM_RESTART': '1', 21:59:51 INFO - 'PAGER': '/bin/cat', 21:59:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:51 INFO - 'PWD': '/builds/slave/test', 21:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:51 INFO - 'SHELL': '/bin/bash', 21:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 21:59:51 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 21:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:51 INFO - 'USER': 'cltbld', 21:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:51 INFO - 'XPC_FLAGS': '0x0', 21:59:51 INFO - 'XPC_SERVICE_NAME': '0', 21:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:51 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:54 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:59:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:55 INFO - Downloading docopt-0.6.1.tar.gz 21:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:55 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:55 INFO - Running setup.py install for blobuploader 21:59:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:59:55 INFO - Running setup.py install for requests 21:59:56 INFO - Running setup.py install for docopt 21:59:56 INFO - Successfully installed blobuploader requests docopt 21:59:56 INFO - Cleaning up... 21:59:56 INFO - Return code: 0 21:59:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:56 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:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:56 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:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:56 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 0x100d173f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb393d9f6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, '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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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:59:56 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:59:56 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:59:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 21:59:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:56 INFO - 'HOME': '/Users/cltbld', 21:59:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:56 INFO - 'LOGNAME': 'cltbld', 21:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:56 INFO - 'MOZ_NO_REMOTE': '1', 21:59:56 INFO - 'NO_EM_RESTART': '1', 21:59:56 INFO - 'PAGER': '/bin/cat', 21:59:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:56 INFO - 'PWD': '/builds/slave/test', 21:59:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:56 INFO - 'SHELL': '/bin/bash', 21:59:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 21:59:56 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 21:59:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:56 INFO - 'USER': 'cltbld', 21:59:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:56 INFO - 'XPC_FLAGS': '0x0', 21:59:56 INFO - 'XPC_SERVICE_NAME': '0', 21:59:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-KlbHxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-BqpzLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-_BN4hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-K3nhQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-esrSwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Hj8lDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Ltuoiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-bZNYla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-q5QczM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-JVUOsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-mpR756-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Uvj6UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:57 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-rvZD6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-ELuIWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-oZrI3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-evYaDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:58 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-mImtMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:58 INFO - Running setup.py install for manifestparser 21:59:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:59:58 INFO - Running setup.py install for mozcrash 21:59:58 INFO - Running setup.py install for mozdebug 21:59:58 INFO - Running setup.py install for mozdevice 21:59:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:59:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:59:59 INFO - Running setup.py install for mozfile 21:59:59 INFO - Running setup.py install for mozhttpd 21:59:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:59:59 INFO - Running setup.py install for mozinfo 21:59:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:59:59 INFO - Running setup.py install for mozInstall 21:59:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:59:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:59:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:59:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:59:59 INFO - Running setup.py install for mozleak 21:59:59 INFO - Running setup.py install for mozlog 21:59:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:00:00 INFO - Running setup.py install for moznetwork 22:00:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:00:00 INFO - Running setup.py install for mozprocess 22:00:00 INFO - Running setup.py install for mozprofile 22:00:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:00:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:00:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:00:00 INFO - Running setup.py install for mozrunner 22:00:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:00:00 INFO - Running setup.py install for mozscreenshot 22:00:00 INFO - Running setup.py install for moztest 22:00:00 INFO - Running setup.py install for mozversion 22:00:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:00:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:01 INFO - Cleaning up... 22:00:01 INFO - Return code: 0 22:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:01 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')]} 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:01 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')]} 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:01 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 0x100d173f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb393d9f6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, '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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 22:00:01 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 22:00:01 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 22:00:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 22:00:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:01 INFO - 'HOME': '/Users/cltbld', 22:00:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:01 INFO - 'LOGNAME': 'cltbld', 22:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:01 INFO - 'MOZ_NO_REMOTE': '1', 22:00:01 INFO - 'NO_EM_RESTART': '1', 22:00:01 INFO - 'PAGER': '/bin/cat', 22:00:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:01 INFO - 'PWD': '/builds/slave/test', 22:00:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:01 INFO - 'SHELL': '/bin/bash', 22:00:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 22:00:01 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 22:00:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:01 INFO - 'USER': 'cltbld', 22:00:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:01 INFO - 'XPC_FLAGS': '0x0', 22:00:01 INFO - 'XPC_SERVICE_NAME': '0', 22:00:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-onpo_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:01 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)) 22:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Yb6YnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-9B_OE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:01 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)) 22:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-rdrhds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:01 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)) 22:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-enGlnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:01 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)) 22:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-vOF8xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:02 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)) 22:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-mIGvn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:02 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)) 22:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-OOzTn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:02 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)) 22:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-R5nXul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:02 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)) 22:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-FdPstq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:02 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)) 22:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-cq4Jxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:02 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)) 22:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-sWv7S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:02 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)) 22:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-gI5MG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:02 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)) 22:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-2_6dNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:02 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-YZ3Tl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:03 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)) 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:03 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-HIwPMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:03 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)) 22:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:03 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-nASIm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:03 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)) 22:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:03 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)) 22:00:03 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)) 22:00:03 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)) 22:00:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:03 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 22:00:03 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 22:00:03 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 22:00:03 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 22:00:03 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 22:00:03 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 22:00:05 INFO - Downloading blessings-1.6.tar.gz 22:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:05 INFO - Installing collected packages: blessings 22:00:05 INFO - Running setup.py install for blessings 22:00:06 INFO - Successfully installed blessings 22:00:06 INFO - Cleaning up... 22:00:06 INFO - Return code: 0 22:00:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:00:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:06 INFO - Reading from file tmpfile_stdout 22:00:06 INFO - Current package versions: 22:00:06 INFO - blessings == 1.6 22:00:06 INFO - blobuploader == 1.2.4 22:00:06 INFO - docopt == 0.6.1 22:00:06 INFO - functools32 == 3.2.3-2 22:00:06 INFO - jsonschema == 2.5.1 22:00:06 INFO - manifestparser == 1.1 22:00:06 INFO - mozInstall == 1.12 22:00:06 INFO - mozcrash == 1.0 22:00:06 INFO - mozdebug == 0.1 22:00:06 INFO - mozdevice == 0.48 22:00:06 INFO - mozfile == 1.2 22:00:06 INFO - mozhttpd == 0.7 22:00:06 INFO - mozinfo == 0.9 22:00:06 INFO - mozleak == 0.1 22:00:06 INFO - mozlog == 3.4 22:00:06 INFO - moznetwork == 0.27 22:00:06 INFO - mozprocess == 0.23 22:00:06 INFO - mozprofile == 0.28 22:00:06 INFO - mozrunner == 6.13 22:00:06 INFO - mozscreenshot == 0.1 22:00:06 INFO - mozsystemmonitor == 0.3 22:00:06 INFO - moztest == 0.7 22:00:06 INFO - mozversion == 1.4 22:00:06 INFO - psutil == 3.1.1 22:00:06 INFO - requests == 1.2.3 22:00:06 INFO - wsgiref == 0.1.2 22:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:06 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')]} 22:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:06 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')]} 22:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:06 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 0x100d173f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb393d9f6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, '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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 22:00:06 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 22:00:06 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 22:00:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 22:00:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:06 INFO - 'HOME': '/Users/cltbld', 22:00:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:06 INFO - 'LOGNAME': 'cltbld', 22:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:06 INFO - 'MOZ_NO_REMOTE': '1', 22:00:06 INFO - 'NO_EM_RESTART': '1', 22:00:06 INFO - 'PAGER': '/bin/cat', 22:00:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:06 INFO - 'PWD': '/builds/slave/test', 22:00:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:06 INFO - 'SHELL': '/bin/bash', 22:00:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 22:00:06 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 22:00:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:06 INFO - 'USER': 'cltbld', 22:00:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:06 INFO - 'XPC_FLAGS': '0x0', 22:00:06 INFO - 'XPC_SERVICE_NAME': '0', 22:00:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 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)) 22:00:07 INFO - Cleaning up... 22:00:07 INFO - Return code: 0 22:00:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100d173f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb393d9f6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, '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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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 22:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 22:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:07 INFO - 'HOME': '/Users/cltbld', 22:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:07 INFO - 'LOGNAME': 'cltbld', 22:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:07 INFO - 'MOZ_NO_REMOTE': '1', 22:00:07 INFO - 'NO_EM_RESTART': '1', 22:00:07 INFO - 'PAGER': '/bin/cat', 22:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:07 INFO - 'PWD': '/builds/slave/test', 22:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:07 INFO - 'SHELL': '/bin/bash', 22:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 22:00:07 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 22:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:07 INFO - 'USER': 'cltbld', 22:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:07 INFO - 'XPC_FLAGS': '0x0', 22:00:07 INFO - 'XPC_SERVICE_NAME': '0', 22:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:00:07 INFO - Cleaning up... 22:00:07 INFO - Return code: 0 22:00:07 INFO - Running post-action listener: _resource_record_post_action 22:00:07 INFO - Running post-action listener: _start_resource_monitoring 22:00:07 INFO - Starting resource monitoring. 22:00:07 INFO - [mozharness: 2016-11-18 06:00:07.849632Z] Finished create-virtualenv step (success) 22:00:07 INFO - [mozharness: 2016-11-18 06:00:07.850577Z] Running install step. 22:00:07 INFO - Running pre-action listener: _resource_record_pre_action 22:00:07 INFO - Running main action method: install 22:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:08 INFO - Reading from file tmpfile_stdout 22:00:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:00:08 INFO - Reading from file tmpfile_stdout 22:00:08 INFO - Output received: 22:00:08 INFO - Usage: mozinstall [options] installer 22:00:08 INFO - Options: 22:00:08 INFO - -h, --help show this help message and exit 22:00:08 INFO - -d DEST, --destination=DEST 22:00:08 INFO - Directory to install application into. [default: 22:00:08 INFO - "/builds/slave/test"] 22:00:08 INFO - --app=APP Application being installed. [default: firefox] 22:00:08 INFO - mkdir: /builds/slave/test/build/application 22:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:00:40 INFO - Reading from file tmpfile_stdout 22:00:40 INFO - Output received: 22:00:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:00:40 INFO - Running post-action listener: _resource_record_post_action 22:00:40 INFO - [mozharness: 2016-11-18 06:00:40.849221Z] Finished install step (success) 22:00:40 INFO - [mozharness: 2016-11-18 06:00:40.849387Z] Running run-tests step. 22:00:40 INFO - Running pre-action listener: _resource_record_pre_action 22:00:40 INFO - Running main action method: run_tests 22:00:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:00:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:00:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:00:40 INFO - 2016-11-17 22:00:40.863 screenresolution[1898:17873] starting screenresolution argv=screenresolution get 22:00:40 INFO - 2016-11-17 22:00:40.866 screenresolution[1898:17873] Display 0: 1600x1200x32@60 22:00:40 INFO - 2016-11-17 22:00:40.872 screenresolution[1899:17875] starting screenresolution argv=screenresolution list 22:00:40 INFO - Available Modes on Display 0 22:00:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:00:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:00:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:00:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:00:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:00:41 INFO - Intel Iris: 22:00:41 INFO - Chipset Model: Intel Iris 22:00:41 INFO - Type: GPU 22:00:41 INFO - Bus: Built-In 22:00:41 INFO - VRAM (Dynamic, Max): 1536 MB 22:00:41 INFO - Vendor: Intel (0x8086) 22:00:41 INFO - Device ID: 0x0a2e 22:00:41 INFO - Revision ID: 0x0009 22:00:41 INFO - Displays: 22:00:41 INFO - Display: 22:00:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:00:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:00:41 INFO - Display Serial Number: 1600x1200 60 22:00:41 INFO - Main Display: Yes 22:00:41 INFO - Mirror: Off 22:00:41 INFO - Online: Yes 22:00:41 INFO - Rotation: Supported 22:00:41 INFO - Return code: 0 22:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:41 INFO - Python 2.7.3 22:00:41 INFO - Return code: 0 22:00:41 INFO - grabbing minidump binary from tooltool 22:00:41 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')]} 22:00:41 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 0x100b2dd30>, '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 0x100994db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b25b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:41 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 22:00:41 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 22:00:41 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 22:00:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:41 INFO - Return code: 0 22:00:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:00:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:00:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--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 22:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0385 --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 22:00:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qOaRzlfnRf/Render', 22:00:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:41 INFO - 'HOME': '/Users/cltbld', 22:00:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:41 INFO - 'LOGNAME': 'cltbld', 22:00:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:41 INFO - 'MOZ_NO_REMOTE': '1', 22:00:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:41 INFO - 'NO_EM_RESTART': '1', 22:00:41 INFO - 'PAGER': '/bin/cat', 22:00:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:41 INFO - 'PWD': '/builds/slave/test', 22:00:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:41 INFO - 'SHELL': '/bin/bash', 22:00:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xt5VwePfyS/Listeners', 22:00:41 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 22:00:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:41 INFO - 'USER': 'cltbld', 22:00:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:41 INFO - 'XPC_FLAGS': '0x0', 22:00:41 INFO - 'XPC_SERVICE_NAME': '0', 22:00:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--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 22:00:41 INFO - mozversion application_buildid: 20161117192228 22:00:41 INFO - mozversion application_changeset: 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a 22:00:41 INFO - mozversion application_display_name: Nightly 22:00:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:41 INFO - mozversion application_name: Firefox 22:00:41 INFO - mozversion application_remotingname: firefox 22:00:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:00:41 INFO - mozversion application_vendor: Mozilla 22:00:41 INFO - mozversion application_version: 53.0a1 22:00:41 INFO - mozversion platform_buildid: 20161117192228 22:00:41 INFO - mozversion platform_changeset: 8e476f8bd52d13cc1648e15ea2b72641c2d7bd8a 22:00:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:00:41 INFO - mozversion platform_version: 53.0a1 22:00:41 INFO - using testdate: 1479448841 22:00:41 INFO - actual date: 1479448841 22:00:41 INFO - starting webserver on 'localhost:53637' 22:00:41 INFO - SUITE-START | Running 2 tests 22:00:41 INFO - TEST-START | dromaeo_css 22:00:41 INFO - operating with platform_type : mac_ 22:00:41 INFO - Initialising browser for dromaeo_css test... 22:00:41 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmptnSm3p/profile http://localhost:53637/getInfo.html) 22:00:44 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 22:00:44 INFO - PROCESS | 1909 | colorDepth:24 22:00:44 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 22:00:44 INFO - PROCESS | 1909 | __metrics 22:00:44 INFO - PROCESS | 1909 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:00:44 INFO - PROCESS | 1909 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:45 INFO - TEST-INFO | 1909: exit 0 22:00:45 INFO - Browser initialized. 22:00:45 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:45 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmptnSm3p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:57 INFO - PROCESS | 1911 | RSS: Main: 243642368 22:00:57 INFO - PROCESS | 1911 | 22:01:48 INFO - PROCESS | 1911 | 1479448908916 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] 22:03:59 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53637/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53637/tests/dromaeo/cssquery-ext.html) 22:04:03 INFO - PROCESS | 1911 | RSS: Main: 518209536 22:04:03 INFO - PROCESS | 1911 | 22:07:06 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53637/tests/dromaeo/cssquery-ext.html (next: http://localhost:53637/tests/dromaeo/cssquery-jquery.html) 22:07:06 INFO - PROCESS | 1911 | RSS: Main: 368971776 22:07:06 INFO - PROCESS | 1911 | 22:10:09 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53637/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53637/tests/dromaeo/cssquery-mootools.html) 22:10:09 INFO - PROCESS | 1911 | RSS: Main: 335441920 22:10:09 INFO - PROCESS | 1911 | 22:13:12 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53637/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53637/tests/dromaeo/cssquery-prototype.html) 22:13:12 INFO - PROCESS | 1911 | RSS: Main: 334823424 22:13:12 INFO - PROCESS | 1911 | 22:16:16 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53637/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53637/tests/dromaeo/cssquery-yui.html) 22:16:16 INFO - PROCESS | 1911 | RSS: Main: 332787712 22:16:16 INFO - PROCESS | 1911 | 22:19:20 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53637/tests/dromaeo/cssquery-yui.html (next: http://localhost:53637/tests/dromaeo/cssquery-dojo.html) 22:19:20 INFO - PROCESS | 1911 | RSS: Main: 508440576 22:19:20 INFO - PROCESS | 1911 | 22:19:20 INFO - PROCESS | 1911 | __start_tp_report 22:19:20 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 22:19:20 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 22:19:20 INFO - PROCESS | 1911 | |i|pagename|runs| 22:19:20 INFO - PROCESS | 1911 | |0;dojo.html;3228.773985820992;3245.98377008115;3262.983685081576;3314.525036358821;3315.751318651102;4686.531346865312;5449.509544141027;5456.454354564542;5530.972345138273;5564.137558678406;4603.516630753773;5508.531774799147;5605.579581531381;5607.130894711316;5647.491725744682;5017.247412888059;5073.264376665381;5075.137226671456;5114.462981386957;5137.922931156036;4364.803583838735;5132.204508301219;5214.973925130388;5216;5244.8688782780355;4984.900301993976;5192;5202.713850738208;5246.763895624687;5279.1817268323475;5047.87380315495;5110.131277682765;5117.488251174853;5118.027574760784;5131.076406246874;4997.200447928314;5053.4946505349535;5078.289039534468;5094.31226784383;5094.872628184288;5523.972380138073;5531.917021244684;5537.0863807471715;5553.944460555384;5561.304836895388;5953.523718102541;5983.192269043667;5991.370906054889;6029.78895738647;6064.02975523914;6184.979478386061;6196.783112591038;6204.906926396107;6216.533759967975;6218.595791273553;5654.067078931971;5683.744231509592;5699.344575373802;5702.714864256854;5713.085906255021;6121.066629478805;6126.589598257208;6126.663033533109;6181.289151747606;6189.381061893865;4926.556609905054;5833.941660583339;5938.8218353449465;5947.434993675594;6039.939600604026;6072.787452439144;6074.058520929263;6074.362191969868;6087.178230938855;6120.663363515049;5980.700964951735;6011.5190784737115;6015.939840601625;6022.879542409128;6024.668643224577;5865.618734782225;5876.647401155944;6001.369856165127;6023.427774361428;6031.819045428557;4813.4945830687975;4834.709917404967;4856.538628830255;4862.854114376574;4874.147024270738;4310.159518893848;4317.935230971538;4323.805428755713;4324.545922678137;4377.8248870044845;5422.810201642924;5497.8075767347955;5602.439756024365;5603.80386686464;5612.130119831432;6018.849528761729;6022.156898034279;6067.7269522871575;6092.5430592705725;6119.07606531266;5567.387587365387;5571.582131340166;5571.997040532743;5572.3870374258795;5603.691796951125;5261.473852614785;5273.868153296198;5281.577473802086;5285.207218917117;5329.786808527616;6107.46191531438;6121.42248870793;6162.44537991565;6183.474404675653;6208.844778880564;6119.807225076679;6119.99004232014;6162.075688646739;6162.661053642093;6166.075088736726;6234.314225435289;6245.18812554365;6245.750169993149;6249.312575616769;6272.247330320391;5821.185034095315;5953.583249172516;5959.76160953557;5960.970195148997;6002.369751176238;4787.329773831736;5949.988501954592;6033.698315084141;6042.214512113397;6042.456178943916;4925.6305777066145;5841.094630332305;5849.502792262535;5852.94147058541;5854.063349864001;5681.0910254359105;5805.82582522525;5862.706864656835;5863.91517569251;5865.090910908816;5733.913991290051;5738.626989245686;5741.655500669973;5746.367899531132;5746.798862039976;5808.970955145197;5836.270466191726;5836.445537673914;5836.678982655994;5847.707614619337;5666.886662266649;5688.488036076773;5694.06048002075;5711.057675483498;5716.657000579979 22:19:20 INFO - PROCESS | 1911 | |1;ext.html;482.4716934956224;483.4609410507284;495.3263561556285;501.5937090956325;529.5578192209505;37482.62517374825;38510;38670.41994370083;38911.22177556454;41055.58944410555;39649.801750991275;40215.59784402163;40333.39499907504;40376.99057523556;40514.59485405145;7325.597092159929;9302.441853488795;9469.443250322409;9482.146606805387;9489.00365461627;8368.497890126582;8516.23353898149;8541.95729021354;8545.444546104514;8547.829043419128;11184.776304473906;11448.198626096177;11499.712507187303;11609.825852612217;11616.36110013949;11215.495302711397;11342.943285283603;11343.773124537463;11348.205625606211;11353.943230283878;8300.958495207486;8518.148185181495;8533.14668533148;11196.440177991068;11287.717807054807;30640.92756753525;31049.06852794397;37399.4390084149;37932.81033594815;37979.24041519154;3301.818399988;3446.7070299024613;3811.5997820228754;3866.2074274773886;3872.956646231054;28433;28992.71007289921;29010.854945725347;29062.27344316388;29116.854415727998;3051.435940677559;3197.600299962505;3239.7732158748895;3249.69127932846;3309.7517686173633;322878;329618;332465;333316;333501;55797.442025580036;56091;56198.43801562014;56236;56332.718336408056;55236;59231.40768592345;59364.70317648384;59466.70266648639;59509.404905951254;15437.382504699686;15650.68698626021;15656.373745050298;15657;15695.372185112468;12094.334811585271;12147.785221477958;12151.5139394425;12161.574344897886;12173.330466824409;14103.717925641635;14407;15790.526284211492;16099.517014489584;16135;4661.13350723263;5298.311219541435;5881.235439392852;5999.100134979701;6036.279660296795;882.6248844241172;890.2077151335317;1017.6489111256604;1060.3213943076437;1083.5340803454433;28112.71887281101;28251.293717657223;28421.289467763472;28494.927557790157;28787.85606071998;1079.1151255970185;1090.4765712457906;1161.517970042423;1187.827764974074;1191.368574655434;13962.441502339996;14566.927165364104;14601.853981460263;14950.775738363933;15004.699906001819;525281;535919;538450;539317;540319;54050.72974635102;54134.72932635312;54241;54328;54408.63978400572;1195.2529668956902;1232.796588562895;1291.231717128307;1327.5419980106847;1340.805583190432;28320.71679283181;28474;29441.85279073591;29449.85275073611;30232.941847035247;42904.57095429006;43195.78402107969;43315.56684433115;43324.35013474737;43379;412209;416878;419648;422254;425250;24833.379165521008;25506.74493255044;26142.86928565345;26349.86825065939;36746.63253367432;42534.93662658458;43405;43600;44102.55897441113;44199.33700994423;35872.820635896656;36111.45832812563;36214.8189259052;37033.44449833308;37224.441633374976;30441.39117217599;36063.27873442569;36644.81677591595;36955.63044369522;37424.438633421065;34928;35660.64339356677;36252.63747362598;36350.63649363472;36459;31418.52872206873;32416.35167296688;32535.861244856318;32675.509867351535;33154.52413924089;21921.232756853435;23748.050077997377;23877.044918203774;24087.397815054763;24619.50760984806 22:19:20 INFO - PROCESS | 1911 | |2;jquery.html;299.6658725521045;337.67920475548226;369.1988385204107;374.08536129164196;395.4819186865205;14876.033057851231;15164.545063648095;19508;19925.99999999998;20804;19690.212391504323;20189.39431817044;20234.59530809383;20236.494087647818;20501.38495845127;5671.943280567193;5984.102384642295;6000.789972350969;6007.038873780196;6027.126066720323;5825.533957283407;5843.64938103713;5884.411558844103;5885.823425297226;5890.499307558863;5262.81580144695;5831.746174572466;5906;5920.437558431942;5926.911096333559;5641.351244606841;5759.107338362561;5823.679697616651;5842.182094506772;5881.558883083764;5106.719130447824;5107.004134193834;5111.795528178868;5114.002769459957;5119.692818430869;24549.263522094367;25205.243842684748;25245.242642720747;25255.747442525524;25379.604121773296;2022.48426651203;2233.3634914049417;2246.9550608987893;2270.943226419336;2328.5110126873205;10220.97790220972;10343.741406464898;12650.304233267167;13523.932380338134;14209.289535523287;1816.8909865408118;1848.3068849181557;1861.8696691231619;1915.6101426307475;1918.7697476302933;80923.38153236962;112975.87024129818;113015.43492282568;113665.4316728411;115143;10489.423081730578;10663.360198388122;10701.571937122584;11248.606298779503;11454.911783380565;14142.151470911778;14368.353424095942;14381.856181438261;14401;14408.20754858493;7818.452708310364;7865.499852565554;8289.171082891784;8391.748247552583;8394.8321033579;8146.67413303473;8166.305864001626;8169.5098294102545;8330.541820199947;8352;3743.2139250757646;4381.824727010948;4439.156560253606;4517.751523666164;4566.406367172246;1641.7209074457132;1672.8410800973888;1906.4566598519632;1938.7479627648597;1960.304092047331;840.7687885831446;909.9671872424714;916.6287653500343;963.889152747429;1021.0861279155115;18979.71530427045;20735.377938661863;20803.68794468084;20852;20983.265585704426;910.2126660438805;925.5141050948306;931.500284541887;934.1545900959643;938.2494004796135;10288.91053012707;10946.332978452308;11081.947215014561;11154;11160.832587511193;400508;460996;462896;465354;465819;93551;106353;115059;117705;123097.38451307865;967.9661211857551;969.5007071358115;1001.4492029383955;1026.1380440430075;1027.6146445083093;17679.73480397821;18401.539961500534;18476.983765892466;18479.53801154982;18492.81507184911;49593.752031239615;49885.75057124836;50437;51076;51815.704607385116;70578.89303581338;70616.6469167651;72675.90986135318;72932;73047;6781.152355955505;7053.753118640823;7103.076600041962;7134.788215653164;7222.638868056471;8939.642414303615;11781.882181178078;11869.228500147463;12229.388530573258;12454.439550220442;10389.844152337871;10657.520411581343;10743.24797264184;10796.946015269874;10869.29349592274;5604.915926261191;10373.325733827278;10505.842412363974;10803.513841876977;10913.618023369145;10197;10296.639617613648;10322.277440579388;10949;11211.943940280247;5857.560682948882;6994.160700715743;7029;7193.244709305657;7218.242084581043;8897.91102088971;10061.694837483588;10224.897751022692;10463.162946964378;10585.8941410588 22:19:20 INFO - PROCESS | 1911 | |3;mootools.html;1330.128765658494;1485.5469081930007;1510.9093454392737;1690.4759524547383;1864.0679660169906;6774.390304872567;7363.595002274873;7762.223777622249;7787;7787.22127787221;7884.408669349793;8172.673093076285;8191.221833925782;8240.093589705128;8255.793605159874;2258.6160352740076;2284.942876428086;2293.919712810052;2293.9541209175804;2296.42589352661;2272.988635056822;2307.0886999635136;2338.462153704649;2342.81687747688;2346.3547524430746;2284.5316710074394;2290.564792689392;2316.988415057931;2319.976800231993;2325.430269583954;2259.3334966184852;2278.259565641165;2289.061484791236;2299.862008279492;2301.861888286708;2304.896279667419;2316.6409206573007;2318.2929206591984;2321.651752237178;2329.801966832821;8152.225538573885;8291.170882911721;8303.501789892565;8311.750647480585;8319.916800831974;4946.629002824767;5009.0482808266315;5146.433892271847;5175.948240517584;5182.792688292464;3336.5996080470254;3505.439129739255;3594.622564630702;3599.5523044329843;3605.5853576838476;1047.5076713944434;1074.75280685442;1090.6237348114887;1091.6015654286127;1096.1504833753825;10241.795164096751;10437.2172087093;10606.78786424275;10612.991765782239;10788.784224315548;3805.8858234253016;4465.37484752135;4633.7683115844075;4669.673122881366;4672.486026537078;9370.90629093714;9371.297152713574;9375.24998000172;9386.202172815387;9390.67132650354;5119.769610367543;5160.870978225575;5170.146925757208;5183.637145399785;5183.766730497136;3994.6205110514456;4255.3616957456625;4375.387445757597;4401.6478681705385;4766.261229509431;3355.8757816131383;3670.376036073874;3737.271232109767;3757.3800322946954;3815.5802861685193;1247.731737676404;1266.7656483550572;1269.571731801723;1287.0540152987546;1287.9613611591667;836.6277006732067;843.9493630382074;882.166352796601;889.8531742262454;930.3766476460787;5431.4840090191365;5445.237666726662;5590.776368945278;5601.467860553241;5830.970845145747;786.2373497707215;906.7687739626485;964.62379671928;975.4098770244042;980.6959842448864;3553.3959226931483;3768.773873567595;3774.6602805747066;3788.791616461121;3843.481130047464;9624.615015399306;9942.652007179713;10021.29850910444;10035.949820250851;10042.598296068221;9208.539573021322;9972.501374931224;9985.750356241153;10001.79996400068;10043.146332561813;7493.775186744407;7718.768436946901;7719.536827790351;7731.188225236269;7743.264389882952;4557.658175636907;5467.890642187213;5565.888682226414;5666.858328541819;5715.371309155907;8966.879140107487;9113.04313047147;9124.49815260167;9224.631014759334;9343.252539796664;7388.448425830421;9250.444973301623;9324.533773311443;9453;9464.621415143318;6969.059177011241;7120.501564890616;7134.964325178341;7136.143662760502;7161.2122666507685;7475.962620186864;7639.77080687558;7730.226977302224;7737.961310193413;7765.029371328584;6951.895721564281;6975;7011.614361210182;7047.506674532733;7166.817475116756;6872.347127022925;6895.6552172390175;6917.342852429011;6922.169339679271;6979.092717946634;6503.414692677493;6509.967450162909;6577.112089867998;6583.341665833378;6592.67036648156;4600.240960241523;4650.441946966385;4712.670113092187;4750.429948406213;4850.345203397496;4165.4168416422335;4688.5545873142;4828.37231159947;4878.658493905393;4933.975330123327 22:19:20 INFO - PROCESS | 1911 | |4;prototype.html;254.37297062740348;296.3465558443633;301.0801999890334;309.37814991866355;312.7826160818232;4403.163398954204;4601.102784956935;4894.5594896459315;4961.87595310117;4982.676126051809;3860.2086572252692;4008.8997775055636;4332.740035597866;4677.672562920597;4840.7579621018895;3841.5774264830848;3868;3878.3019056569806;3880.4373365861934;3881.156450685916;3416.692497675209;3535.3636345457808;3861.4980052593123;3864.4396562498423;3888.2806680764006;3237.7247933925646;3262.3801477719276;3607.5310209672707;3630.5824830144606;3854.4603755474254;3381.7970921744527;3466.653334666526;3837.884863454101;3863.265979463907;3867.2265546890735;2948.6019387382644;3065.371598822236;3309.321589074234;3313.9834300828584;3384.8984530464127;4873.415190177166;4893.657443978923;4895.363602731658;4896.583790377822;4945.53017463344;3848.826802793881;3980.1641655252433;4268.509121451011;4297.634701050414;4306.7631280279575;5156.278121063054;5175.120229560984;5183.067047931371;5209.400918894337;5223.921641175385;3604.585472670624;3625.6374362563797;3631.837811900193;3638.653068770628;3641.326354624403;5036.298320734258;5150.995555866645;5371.791346946906;5375.2261753621215;5446.809361672362;3380.9323813523592;3558.1282585766653;3660.3228402745576;3663.6336366363685;3690.28039532294;3697.98305465999;3708.1841994761107;3717.3308804415465;3727.2481933491217;3744.2885851688093;4264.253755592759;4269.829206831692;4287;4292.957070429318;4293.162833247549;4919.065377578248;5183.092958732207;5191.9480805192225;5228.006678731029;5228.183426098969;1170.7248796532808;1195.4739914437619;1198.3948106206485;1201.7167381974318;1212.2605210821391;663.3731124087788;705.9152901651835;817.5013241922422;824.6701319472259;830.4021104804531;3916.6475017248586;4553.385292985405;4897.681650692693;4944.626579241984;4953.702777833341;5365.283109404953;5381.165919282517;5387.299651045339;5413.458654134633;5416.891662166813;4010.47863777707;4338.240807858612;4911.361523002059;4911.557959783637;5058.002089174829;2288.4736510602656;2374.45387560862;2417.045267119478;2516.5721827289403;2673.5321318769525;4684.149760844447;4749.810007599726;5085.95737873735;5217.713025783542;5327.254184414185;4610.101030299126;4634.914288570157;4925.458199598042;5033.612149137423;5117.769700363493;4937.247691754221;4997.975010124999;5233.973830130977;5241.554467870274;5294.497022782906;4328.502222244482;4747.8575642730775;5018.372703412074;5061.836926335044;5234.476552344735;4274.829006839816;4710.905781884275;4884.535969082932;4976.776045078052;4978.726170060681;4706.929396058993;5090.54919347984;5240.3492899737985;5267.2889159962915;5270.314859068297;3515.3616007432183;3550.1479644885558;3577.856885724542;3585.8924232273075;3611;4616.099860527165;4775.808967641256;4814.398200224972;5019.297298378303;5036.445990940921;4250.36244563318;4373.707813545645;4379.58393952574;4741.217699079752;4980.850574482626;4019.618136277049;4277.037666525007;4818.95181048185;4885.413750349981;4915.787895447134;4261.95738042628;4728.115849331974;4748.976255118702;4761.095561775318;4772.284157376422;4507.746126936532;4514.503404625423;4686.507916668701;4873.6832105913;4882.707037577757;4100.138970816042;4110.253142414402;4211.810468528863;4698.110661942949;4739.398057476274 22:19:20 INFO - PROCESS | 1911 | |5;yui.html;672.1631568696973;676.3777324861127;679.8742232686951;761.1018997582853;771.1363273134089;13678.589642310733;14493.260808702957;15479.07125572465;16292.75560866585;16380;14884.25578721065;15035.398584056651;15231.086134831918;15308.770368444482;15459;816.9550674712889;840.861257892447;842.9199226073513;843.6245870587591;844.8437039147777;655.0501772429972;678.6572780745716;832.4505826154739;840.474703310431;840.9957950210271;719.1118968074423;845.8477474054667;870.6473878079388;878.995605021974;886.7650072730731;878.7319867440428;879.9692010779656;880.5817236812463;881.6385282034336;882.8940527136721;511.7057691827177;648.1865259099847;649.1723053107279;649.2987573420694;650.2911826109563;11975.281483110954;13726.862731372657;14302.642433939234;14369.712605747827;14667.266636668124;12829;13042.347882605833;13237.205767653972;13303.600891973256;13314.334283285894;9454.669086581936;10969.725756856064;11283.37941413222;11328.830067548994;11831.112666549958;3605.56733192016;3702.092987218122;3716.9442458363146;3800.4869342638945;3840.0783811885226;78689.60655196688;78892.60553697195;79865;79923.60038199772;80137.59931200364;10338.948305258426;10393.740156495996;10394.792104157874;10564.683059508227;10809.35143891369;19614.21543138287;19634;19652.017399129985;19655.606887862163;19669.11488982999;7022.964885175541;7127.964360178166;7131.643417829087;7145.4640901931525;7619.390448764086;4276.91446171081;4409.911801764011;4428.180786554498;4540.84107056258;4557.430321209848;3393.2365217826286;3467.930641387158;3516.8065756383644;3518.1204698825295;3522.1546828761425;659.6833519910374;660.6762686283687;692.1866806502339;710.1832892173938;717.8851383778571;579.8637320229743;588.5703436491385;602.235161345098;662.159057996342;666.9899951500731;8123.228293312126;8536.658533658709;9136.543172841331;9592.424454532751;9646.131848133702;594.378874076591;606.3269770554681;673.6631684157921;677.8881484555092;699.140057728986;4129.380592911088;4150.232207041707;4316.223079845595;4389.978050109729;4475.082608065339;95423;96517.51741241249;97640.5287921141;98183.01816981738;101695;68215.65892170508;70924;85733;89829.55085224663;90028.5498572503;70499;70670.58658826795;71483.92774108393;72775.90836137462;73973;9121;9324.860127098234;9365.859512107187;9376.531173441164;9401.482918439551;43749;43901.46344877914;46559;49196.50803491919;50560.494395055575;50169;66937.99593006012;70789.29210707828;72752;73155.17112072241;11383.601573944872;11518.481668325114;11879.881201188224;11959.820602691141;12265.570705025639;11868.76262474763;13216.867831321564;13538;13761.348638163485;13773.655658608615;10037;12771.297578633264;12862.742745144858;13342.06605537642;13379.397927093109;11232.3260604364;12585.811212831632;12801.93599031999;13145.474181032652;13447.394867230802;10771.407572583583;12380.504779808707;12931.22412655206;13045.934770326088;13050.54323098687;9008.954955225181;10936.234463587472;10950.06924411402;11015.339079655247;11320.547178113113;9854.497682373816;10932;10980.945095274472;11137.276077054965;11174.608888688857 22:19:20 INFO - PROCESS | 1911 | __end_tp_report 22:19:20 INFO - PROCESS | 1911 | __start_cc_report 22:19:20 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,3321 22:19:20 INFO - PROCESS | 1911 | __end_cc_report 22:19:20 INFO - PROCESS | 1911 | __startTimestamp1479449960857__endTimestamp 22:19:20 INFO - PROCESS | 1911 | 22:19:20 INFO - PROCESS | 1911 | ------- Summary: start ------- 22:19:20 INFO - PROCESS | 1911 | Number of tests: 6 22:19:20 INFO - PROCESS | 1911 | 22:19:20 INFO - PROCESS | 1911 | [#0] dojo.html Cycles:165 Average:5561.39 Median:5713.09 stddev:628.07 (11.0%) stddev-sans-first:602.75 22:19:20 INFO - PROCESS | 1911 | Values: 3228.8 3246.0 3263.0 3314.5 3315.8 4686.5 5449.5 5456.5 5531.0 5564.1 4603.5 5508.5 5605.6 5607.1 5647.5 5017.2 5073.3 5075.1 5114.5 5137.9 4364.8 5132.2 5215.0 5216.0 5244.9 4984.9 5192.0 5202.7 5246.8 5279.2 5047.9 5110.1 5117.5 5118.0 5131.1 4997.2 5053.5 5078.3 5094.3 5094.9 5524.0 5531.9 5537.1 5553.9 5561.3 5953.5 5983.2 5991.4 6029.8 6064.0 6185.0 6196.8 6204.9 6216.5 6218.6 5654.1 5683.7 5699.3 5702.7 5713.1 6121.1 6126.6 6126.7 6181.3 6189.4 4926.6 5833.9 5938.8 5947.4 6039.9 6072.8 6074.1 6074.4 6087.2 6120.7 5980.7 6011.5 6015.9 6022.9 6024.7 5865.6 5876.6 6001.4 6023.4 6031.8 4813.5 4834.7 4856.5 4862.9 4874.1 4310.2 4317.9 4323.8 4324.5 4377.8 5422.8 5497.8 5602.4 5603.8 5612.1 6018.8 6022.2 6067.7 6092.5 6119.1 5567.4 5571.6 5572.0 5572.4 5603.7 5261.5 5273.9 5281.6 5285.2 5329.8 6107.5 6121.4 6162.4 6183.5 6208.8 6119.8 6120.0 6162.1 6162.7 6166.1 6234.3 6245.2 6245.8 6249.3 6272.2 5821.2 5953.6 5959.8 5961.0 6002.4 4787.3 5950.0 6033.7 6042.2 6042.5 4925.6 5841.1 5849.5 5852.9 5854.1 5681.1 5805.8 5862.7 5863.9 5865.1 5733.9 5738.6 5741.7 5746.4 5746.8 5809.0 5836.3 5836.4 5836.7 5847.7 5666.9 5688.5 5694.1 5711.1 5716.7 22:19:20 INFO - PROCESS | 1911 | 22:19:20 INFO - PROCESS | 1911 | [#1] ext.html Cycles:180 Average:57158.17 Median:35766.73 stddev:116077.19 (324.5%) stddev-sans-first:116324.82 22:19:20 INFO - PROCESS | 1911 | Values: 482.5 483.5 495.3 501.6 529.6 37482.6 38510.0 38670.4 38911.2 41055.6 39649.8 40215.6 40333.4 40377.0 40514.6 7325.6 9302.4 9469.4 9482.1 9489.0 8368.5 8516.2 8542.0 8545.4 8547.8 11184.8 11448.2 11499.7 11609.8 11616.4 11215.5 11342.9 11343.8 11348.2 11353.9 8301.0 8518.1 8533.1 11196.4 11287.7 30640.9 31049.1 37399.4 37932.8 37979.2 3301.8 3446.7 3811.6 3866.2 3873.0 28433.0 28992.7 29010.9 29062.3 29116.9 3051.4 3197.6 3239.8 3249.7 3309.8 322878.0 329618.0 332465.0 333316.0 333501.0 55797.4 56091.0 56198.4 56236.0 56332.7 55236.0 59231.4 59364.7 59466.7 59509.4 15437.4 15650.7 15656.4 15657.0 15695.4 12094.3 12147.8 12151.5 12161.6 12173.3 14103.7 14407.0 15790.5 16099.5 16135.0 4661.1 5298.3 5881.2 5999.1 6036.3 882.6 890.2 1017.6 1060.3 1083.5 28112.7 28251.3 28421.3 28494.9 28787.9 1079.1 1090.5 1161.5 1187.8 1191.4 13962.4 14566.9 14601.9 14950.8 15004.7 525281.0 535919.0 538450.0 539317.0 540319.0 54050.7 54134.7 54241.0 54328.0 54408.6 1195.3 1232.8 1291.2 1327.5 1340.8 28320.7 28474.0 29441.9 29449.9 30232.9 42904.6 43195.8 43315.6 43324.4 43379.0 412209.0 416878.0 419648.0 422254.0 425250.0 24833.4 25506.7 26142.9 26349.9 36746.6 42534.9 43405.0 43600.0 44102.6 44199.3 35872.8 36111.5 36214.8 37033.4 37224.4 30441.4 36063.3 36644.8 36955.6 37424.4 34928.0 35660.6 36252.6 36350.6 36459.0 31418.5 32416.4 32535.9 32675.5 33154.5 21921.2 23748.1 23877.0 24087.4 24619.5 22:19:20 INFO - PROCESS | 1911 | 22:19:20 INFO - PROCESS | 1911 | [#2] jquery.html Cycles:180 Average:29641.86 Median:25225.24 stddev:76237.59 (302.2%) stddev-sans-first:76419.63 22:19:20 INFO - PROCESS | 1911 | Values: 299.7 337.7 369.2 374.1 395.5 14876.0 15164.5 19508.0 19926.0 20804.0 19690.2 20189.4 20234.6 20236.5 20501.4 5671.9 5984.1 6000.8 6007.0 6027.1 5825.5 5843.6 5884.4 5885.8 5890.5 5262.8 5831.7 5906.0 5920.4 5926.9 5641.4 5759.1 5823.7 5842.2 5881.6 5106.7 5107.0 5111.8 5114.0 5119.7 24549.3 25205.2 25245.2 25255.7 25379.6 2022.5 2233.4 2247.0 2270.9 2328.5 10221.0 10343.7 12650.3 13523.9 14209.3 1816.9 1848.3 1861.9 1915.6 1918.8 80923.4 112975.9 113015.4 113665.4 115143.0 10489.4 10663.4 10701.6 11248.6 11454.9 14142.2 14368.4 14381.9 14401.0 14408.2 7818.5 7865.5 8289.2 8391.7 8394.8 8146.7 8166.3 8169.5 8330.5 8352.0 3743.2 4381.8 4439.2 4517.8 4566.4 1641.7 1672.8 1906.5 1938.7 1960.3 840.8 910.0 916.6 963.9 1021.1 18979.7 20735.4 20803.7 20852.0 20983.3 910.2 925.5 931.5 934.2 938.2 10288.9 10946.3 11081.9 11154.0 11160.8 400508.0 460996.0 462896.0 465354.0 465819.0 93551.0 106353.0 115059.0 117705.0 123097.4 968.0 969.5 1001.4 1026.1 1027.6 17679.7 18401.5 18477.0 18479.5 18492.8 49593.8 49885.8 50437.0 51076.0 51815.7 70578.9 70616.6 72675.9 72932.0 73047.0 6781.2 7053.8 7103.1 7134.8 7222.6 8939.6 11781.9 11869.2 12229.4 12454.4 10389.8 10657.5 10743.2 10796.9 10869.3 5604.9 10373.3 10505.8 10803.5 10913.6 10197.0 10296.6 10322.3 10949.0 11211.9 5857.6 6994.2 7029.0 7193.2 7218.2 8897.9 10061.7 10224.9 10463.2 10585.9 22:19:20 INFO - PROCESS | 1911 | 22:19:20 INFO - PROCESS | 1911 | [#3] mootools.html Cycles:180 Average:5342.69 Median:5165.51 stddev:2903.34 (56.2%) stddev-sans-first:2895.82 22:19:20 INFO - PROCESS | 1911 | Values: 1330.1 1485.5 1510.9 1690.5 1864.1 6774.4 7363.6 7762.2 7787.0 7787.2 7884.4 8172.7 8191.2 8240.1 8255.8 2258.6 2284.9 2293.9 2294.0 2296.4 2273.0 2307.1 2338.5 2342.8 2346.4 2284.5 2290.6 2317.0 2320.0 2325.4 2259.3 2278.3 2289.1 2299.9 2301.9 2304.9 2316.6 2318.3 2321.7 2329.8 8152.2 8291.2 8303.5 8311.8 8319.9 4946.6 5009.0 5146.4 5175.9 5182.8 3336.6 3505.4 3594.6 3599.6 3605.6 1047.5 1074.8 1090.6 1091.6 1096.2 10241.8 10437.2 10606.8 10613.0 10788.8 3805.9 4465.4 4633.8 4669.7 4672.5 9370.9 9371.3 9375.2 9386.2 9390.7 5119.8 5160.9 5170.1 5183.6 5183.8 3994.6 4255.4 4375.4 4401.6 4766.3 3355.9 3670.4 3737.3 3757.4 3815.6 1247.7 1266.8 1269.6 1287.1 1288.0 836.6 843.9 882.2 889.9 930.4 5431.5 5445.2 5590.8 5601.5 5831.0 786.2 906.8 964.6 975.4 980.7 3553.4 3768.8 3774.7 3788.8 3843.5 9624.6 9942.7 10021.3 10035.9 10042.6 9208.5 9972.5 9985.8 10001.8 10043.1 7493.8 7718.8 7719.5 7731.2 7743.3 4557.7 5467.9 5565.9 5666.9 5715.4 8966.9 9113.0 9124.5 9224.6 9343.3 7388.4 9250.4 9324.5 9453.0 9464.6 6969.1 7120.5 7135.0 7136.1 7161.2 7476.0 7639.8 7730.2 7738.0 7765.0 6951.9 6975.0 7011.6 7047.5 7166.8 6872.3 6895.7 6917.3 6922.2 6979.1 6503.4 6510.0 6577.1 6583.3 6592.7 4600.2 4650.4 4712.7 4750.4 4850.3 4165.4 4688.6 4828.4 4878.7 4934.0 22:19:20 INFO - PROCESS | 1911 | 22:19:20 INFO - PROCESS | 1911 | [#4] prototype.html Cycles:180 Average:4095.25 Median:4577.24 stddev:1229.41 (26.9%) stddev-sans-first:1198.58 22:19:20 INFO - PROCESS | 1911 | Values: 254.4 296.3 301.1 309.4 312.8 4403.2 4601.1 4894.6 4961.9 4982.7 3860.2 4008.9 4332.7 4677.7 4840.8 3841.6 3868.0 3878.3 3880.4 3881.2 3416.7 3535.4 3861.5 3864.4 3888.3 3237.7 3262.4 3607.5 3630.6 3854.5 3381.8 3466.7 3837.9 3863.3 3867.2 2948.6 3065.4 3309.3 3314.0 3384.9 4873.4 4893.7 4895.4 4896.6 4945.5 3848.8 3980.2 4268.5 4297.6 4306.8 5156.3 5175.1 5183.1 5209.4 5223.9 3604.6 3625.6 3631.8 3638.7 3641.3 5036.3 5151.0 5371.8 5375.2 5446.8 3380.9 3558.1 3660.3 3663.6 3690.3 3698.0 3708.2 3717.3 3727.2 3744.3 4264.3 4269.8 4287.0 4293.0 4293.2 4919.1 5183.1 5191.9 5228.0 5228.2 1170.7 1195.5 1198.4 1201.7 1212.3 663.4 705.9 817.5 824.7 830.4 3916.6 4553.4 4897.7 4944.6 4953.7 5365.3 5381.2 5387.3 5413.5 5416.9 4010.5 4338.2 4911.4 4911.6 5058.0 2288.5 2374.5 2417.0 2516.6 2673.5 4684.1 4749.8 5086.0 5217.7 5327.3 4610.1 4634.9 4925.5 5033.6 5117.8 4937.2 4998.0 5234.0 5241.6 5294.5 4328.5 4747.9 5018.4 5061.8 5234.5 4274.8 4710.9 4884.5 4976.8 4978.7 4706.9 5090.5 5240.3 5267.3 5270.3 3515.4 3550.1 3577.9 3585.9 3611.0 4616.1 4775.8 4814.4 5019.3 5036.4 4250.4 4373.7 4379.6 4741.2 4980.9 4019.6 4277.0 4819.0 4885.4 4915.8 4262.0 4728.1 4749.0 4761.1 4772.3 4507.7 4514.5 4686.5 4873.7 4882.7 4100.1 4110.3 4211.8 4698.1 4739.4 22:19:20 INFO - PROCESS | 1911 | 22:19:20 INFO - PROCESS | 1911 | [#5] yui.html Cycles:180 Average:18734.83 Median:47877.75 stddev:26195.27 (54.7%) stddev-sans-first:26233.65 22:19:20 INFO - PROCESS | 1911 | Values: 672.2 676.4 679.9 761.1 771.1 13678.6 14493.3 15479.1 16292.8 16380.0 14884.3 15035.4 15231.1 15308.8 15459.0 817.0 840.9 842.9 843.6 844.8 655.1 678.7 832.5 840.5 841.0 719.1 845.8 870.6 879.0 886.8 878.7 880.0 880.6 881.6 882.9 511.7 648.2 649.2 649.3 650.3 11975.3 13726.9 14302.6 14369.7 14667.3 12829.0 13042.3 13237.2 13303.6 13314.3 9454.7 10969.7 11283.4 11328.8 11831.1 3605.6 3702.1 3716.9 3800.5 3840.1 78689.6 78892.6 79865.0 79923.6 80137.6 10338.9 10393.7 10394.8 10564.7 10809.4 19614.2 19634.0 19652.0 19655.6 19669.1 7023.0 7128.0 7131.6 7145.5 7619.4 4276.9 4409.9 4428.2 4540.8 4557.4 3393.2 3467.9 3516.8 3518.1 3522.2 659.7 660.7 692.2 710.2 717.9 579.9 588.6 602.2 662.2 667.0 8123.2 8536.7 9136.5 9592.4 9646.1 594.4 606.3 673.7 677.9 699.1 4129.4 4150.2 4316.2 4390.0 4475.1 95423.0 96517.5 97640.5 98183.0 101695.0 68215.7 70924.0 85733.0 89829.6 90028.5 70499.0 70670.6 71483.9 72775.9 73973.0 9121.0 9324.9 9365.9 9376.5 9401.5 43749.0 43901.5 46559.0 49196.5 50560.5 50169.0 66938.0 70789.3 72752.0 73155.2 11383.6 11518.5 11879.9 11959.8 12265.6 11868.8 13216.9 13538.0 13761.3 13773.7 10037.0 12771.3 12862.7 13342.1 13379.4 11232.3 12585.8 12801.9 13145.5 13447.4 10771.4 12380.5 12931.2 13045.9 13050.5 9009.0 10936.2 10950.1 11015.3 11320.5 9854.5 10932.0 10980.9 11137.3 11174.6 22:19:20 INFO - PROCESS | 1911 | -------- Summary: end -------- 22:19:20 INFO - PROCESS | 1911 | 22:19:21 INFO - TEST-INFO | 1911: exit 0 22:19:21 INFO - TEST-OK | dromaeo_css | took 1120147ms 22:19:21 INFO - TEST-START | kraken 22:19:21 INFO - operating with platform_type : mac_ 22:19:21 INFO - Initialising browser for kraken test... 22:19:21 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpuuxDF7/profile http://localhost:53637/getInfo.html) 22:19:24 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 22:19:24 INFO - PROCESS | 1914 | colorDepth:24 22:19:24 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 22:19:24 INFO - PROCESS | 1914 | __metrics 22:19:24 INFO - PROCESS | 1914 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:19:24 INFO - PROCESS | 1914 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:19:25 INFO - TEST-INFO | 1914: exit 0 22:19:25 INFO - Browser initialized. 22:19:25 INFO - Running cycle 1/1 for kraken test... 22:19:25 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpuuxDF7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:37 INFO - PROCESS | 1915 | RSS: Main: 236109824 22:19:37 INFO - PROCESS | 1915 | 22:19:40 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53637/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:41 INFO - PROCESS | 1915 | RSS: Main: 294805504 22:19:41 INFO - PROCESS | 1915 | 22:19:44 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53637/tests/kraken/driver.html?testName=audio-dft) 22:19:44 INFO - PROCESS | 1915 | RSS: Main: 296452096 22:19:44 INFO - PROCESS | 1915 | 22:19:48 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53637/tests/kraken/driver.html?testName=audio-fft) 22:19:48 INFO - PROCESS | 1915 | RSS: Main: 385110016 22:19:48 INFO - PROCESS | 1915 | 22:19:50 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53637/tests/kraken/driver.html?testName=audio-oscillator) 22:19:51 INFO - PROCESS | 1915 | RSS: Main: 287145984 22:19:51 INFO - PROCESS | 1915 | 22:19:53 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53637/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:54 INFO - PROCESS | 1915 | RSS: Main: 291770368 22:19:54 INFO - PROCESS | 1915 | 22:19:56 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53637/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:57 INFO - PROCESS | 1915 | RSS: Main: 334868480 22:19:57 INFO - PROCESS | 1915 | 22:20:00 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53637/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:01 INFO - PROCESS | 1915 | RSS: Main: 336134144 22:20:01 INFO - PROCESS | 1915 | 22:20:03 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53637/tests/kraken/driver.html?testName=json-parse-financial) 22:20:04 INFO - PROCESS | 1915 | RSS: Main: 333869056 22:20:04 INFO - PROCESS | 1915 | 22:20:06 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53637/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:06 INFO - PROCESS | 1915 | RSS: Main: 307920896 22:20:06 INFO - PROCESS | 1915 | 22:20:08 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53637/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:20:09 INFO - PROCESS | 1915 | RSS: Main: 310423552 22:20:09 INFO - PROCESS | 1915 | 22:20:11 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53637/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:12 INFO - PROCESS | 1915 | RSS: Main: 312913920 22:20:12 INFO - PROCESS | 1915 | 22:20:15 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:15 INFO - PROCESS | 1915 | RSS: Main: 324067328 22:20:15 INFO - PROCESS | 1915 | 22:20:18 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:19 INFO - PROCESS | 1915 | RSS: Main: 324317184 22:20:19 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53637/tests/kraken/driver.html?testName=ai-astar) 22:20:21 INFO - PROCESS | 1915 | RSS: Main: 367357952 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | __start_tp_report 22:20:21 INFO - PROCESS | 1915 | _x_x_mozilla_page_load 22:20:21 INFO - PROCESS | 1915 | _x_x_mozilla_page_load_details 22:20:21 INFO - PROCESS | 1915 | |i|pagename|runs| 22:20:21 INFO - PROCESS | 1915 | |0;ai-astar;103;159;163;111;111;113;113;112;111;111 22:20:21 INFO - PROCESS | 1915 | |1;audio-beat-detection;148;112;110;170;119;113;112;107;144;102 22:20:21 INFO - PROCESS | 1915 | |2;audio-dft;183;184;185;184;184;183;183;180;181;182 22:20:21 INFO - PROCESS | 1915 | |3;audio-fft;79;58;59;87;59;58;58;58;81;59 22:20:21 INFO - PROCESS | 1915 | |4;audio-oscillator;93;70;91;70;69;69;89;67;70;92 22:20:21 INFO - PROCESS | 1915 | |5;imaging-gaussian-blur;88;85;87;85;89;122;88;85;87;85 22:20:21 INFO - PROCESS | 1915 | |6;imaging-darkroom;96;96;96;99;96;95;96;95;96;97 22:20:21 INFO - PROCESS | 1915 | |7;imaging-desaturate;89;87;85;86;87;86;94;131;111;85 22:20:21 INFO - PROCESS | 1915 | |8;json-parse-financial;55;53;53;53;57;54;54;55;53;54 22:20:21 INFO - PROCESS | 1915 | |9;json-stringify-tinderbox;66;66;72;79;73;71;71;71;71;70 22:20:21 INFO - PROCESS | 1915 | |10;stanford-crypto-aes;88;87;87;87;88;87;86;86;85;86 22:20:21 INFO - PROCESS | 1915 | |11;stanford-crypto-ccm;150;152;160;159;165;146;161;156;204;172 22:20:21 INFO - PROCESS | 1915 | |12;stanford-crypto-pbkdf2;173;171;173;171;176;199;173;198;225;178 22:20:21 INFO - PROCESS | 1915 | |13;stanford-crypto-sha256-iterative;67;68;68;67;69;81;84;85;69;66 22:20:21 INFO - PROCESS | 1915 | __end_tp_report 22:20:21 INFO - PROCESS | 1915 | __start_cc_report 22:20:21 INFO - PROCESS | 1915 | _x_x_mozilla_cycle_collect,1993 22:20:21 INFO - PROCESS | 1915 | __end_cc_report 22:20:21 INFO - PROCESS | 1915 | __startTimestamp1479450021599__endTimestamp 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | ------- Summary: start ------- 22:20:21 INFO - PROCESS | 1915 | Number of tests: 14 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#0] ai-astar Cycles:10 Average:120.70 Median:112.50 stddev:21.45 (19.1%) stddev-sans-first:21.77 22:20:21 INFO - PROCESS | 1915 | Values: 103.0 159.0 163.0 111.0 111.0 113.0 113.0 112.0 111.0 111.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:116.00 stddev:22.35 (19.3%) stddev-sans-first:21.90 22:20:21 INFO - PROCESS | 1915 | Values: 148.0 112.0 110.0 170.0 119.0 113.0 112.0 107.0 144.0 102.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:1.52 (0.8%) stddev-sans-first:1.62 22:20:21 INFO - PROCESS | 1915 | Values: 183.0 184.0 185.0 184.0 184.0 183.0 183.0 180.0 181.0 182.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#3] audio-fft Cycles:10 Average:65.60 Median:59.00 stddev:11.72 (19.9%) stddev-sans-first:11.38 22:20:21 INFO - PROCESS | 1915 | Values: 79.0 58.0 59.0 87.0 59.0 58.0 58.0 58.0 81.0 59.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:79.50 stddev:11.48 (14.4%) stddev-sans-first:10.82 22:20:21 INFO - PROCESS | 1915 | Values: 93.0 70.0 91.0 70.0 69.0 69.0 89.0 67.0 70.0 92.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:87.00 stddev:11.31 (13.0%) stddev-sans-first:11.97 22:20:21 INFO - PROCESS | 1915 | Values: 88.0 85.0 87.0 85.0 89.0 122.0 88.0 85.0 87.0 85.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 22:20:21 INFO - PROCESS | 1915 | Values: 96.0 96.0 96.0 99.0 96.0 95.0 96.0 95.0 96.0 97.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:86.50 stddev:15.17 (17.5%) stddev-sans-first:15.98 22:20:21 INFO - PROCESS | 1915 | Values: 89.0 87.0 85.0 86.0 87.0 86.0 94.0 131.0 111.0 85.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.29 (2.4%) stddev-sans-first:1.32 22:20:21 INFO - PROCESS | 1915 | Values: 55.0 53.0 53.0 53.0 57.0 54.0 54.0 55.0 53.0 54.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.00 stddev:3.65 (5.1%) stddev-sans-first:3.40 22:20:21 INFO - PROCESS | 1915 | Values: 66.0 66.0 72.0 79.0 73.0 71.0 71.0 71.0 71.0 70.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.00 stddev:0.95 (1.1%) stddev-sans-first:0.88 22:20:21 INFO - PROCESS | 1915 | Values: 88.0 87.0 87.0 87.0 88.0 87.0 86.0 86.0 85.0 86.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#11] stanford-crypto-ccm Cycles:10 Average:162.50 Median:160.50 stddev:16.40 (10.2%) stddev-sans-first:16.76 22:20:21 INFO - PROCESS | 1915 | Values: 150.0 152.0 160.0 159.0 165.0 146.0 161.0 156.0 204.0 172.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.70 Median:177.00 stddev:17.96 (10.1%) stddev-sans-first:18.62 22:20:21 INFO - PROCESS | 1915 | Values: 173.0 171.0 173.0 171.0 176.0 199.0 173.0 198.0 225.0 178.0 22:20:21 INFO - PROCESS | 1915 | 22:20:21 INFO - PROCESS | 1915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:69.00 stddev:7.66 (11.1%) stddev-sans-first:7.87 22:20:21 INFO - PROCESS | 1915 | Values: 67.0 68.0 68.0 67.0 69.0 81.0 84.0 85.0 69.0 66.0 22:20:21 INFO - PROCESS | 1915 | -------- Summary: end -------- 22:20:21 INFO - PROCESS | 1915 | 22:20:22 INFO - TEST-INFO | 1915: exit 0 22:20:22 INFO - TEST-OK | kraken | took 61050ms 22:20:22 INFO - SUITE-END | took 1181s 22:20:22 INFO - Completed test suite (00:19:41) 22:20:22 INFO - javascript benchmark 22:20:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3228.773985820992, 3245.98377008115, 3262.983685081576, 3314.525036358821, 3315.751318651102, 4686.531346865312, 5449.509544141027, 5456.454354564542, 5530.972345138273, 5564.137558678406, 4603.516630753773, 5508.531774799147, 5605.579581531381, 5607.130894711316, 5647.491725744682, 5017.247412888059, 5073.264376665381, 5075.137226671456, 5114.462981386957, 5137.922931156036, 4364.803583838735, 5132.204508301219, 5214.973925130388, 5216.0, 5244.8688782780355, 4984.900301993976, 5192.0, 5202.713850738208, 5246.763895624687, 5279.1817268323475, 5047.87380315495, 5110.131277682765, 5117.488251174853, 5118.027574760784, 5131.076406246874, 4997.200447928314, 5053.4946505349535, 5078.289039534468, 5094.31226784383, 5094.872628184288, 5523.972380138073, 5531.917021244684, 5537.0863807471715, 5553.944460555384, 5561.304836895388, 5953.523718102541, 5983.192269043667, 5991.370906054889, 6029.78895738647, 6064.02975523914, 6184.979478386061, 6196.783112591038, 6204.906926396107, 6216.533759967975, 6218.595791273553, 5654.067078931971, 5683.744231509592, 5699.344575373802, 5702.714864256854, 5713.085906255021, 6121.066629478805, 6126.589598257208, 6126.663033533109, 6181.289151747606, 6189.381061893865, 4926.556609905054, 5833.941660583339, 5938.8218353449465, 5947.434993675594, 6039.939600604026, 6072.787452439144, 6074.058520929263, 6074.362191969868, 6087.178230938855, 6120.663363515049, 5980.700964951735, 6011.5190784737115, 6015.939840601625, 6022.879542409128, 6024.668643224577, 5865.618734782225, 5876.647401155944, 6001.369856165127, 6023.427774361428, 6031.819045428557, 4813.4945830687975, 4834.709917404967, 4856.538628830255, 4862.854114376574, 4874.147024270738, 4310.159518893848, 4317.935230971538, 4323.805428755713, 4324.545922678137, 4377.8248870044845, 5422.810201642924, 5497.8075767347955, 5602.439756024365, 5603.80386686464, 5612.130119831432, 6018.849528761729, 6022.156898034279, 6067.7269522871575, 6092.5430592705725, 6119.07606531266, 5567.387587365387, 5571.582131340166, 5571.997040532743, 5572.3870374258795, 5603.691796951125, 5261.473852614785, 5273.868153296198, 5281.577473802086, 5285.207218917117, 5329.786808527616, 6107.46191531438, 6121.42248870793, 6162.44537991565, 6183.474404675653, 6208.844778880564, 6119.807225076679, 6119.99004232014, 6162.075688646739, 6162.661053642093, 6166.075088736726, 6234.314225435289, 6245.18812554365, 6245.750169993149, 6249.312575616769, 6272.247330320391, 5821.185034095315, 5953.583249172516, 5959.76160953557, 5960.970195148997, 6002.369751176238, 4787.329773831736, 5949.988501954592, 6033.698315084141, 6042.214512113397, 6042.456178943916, 4925.6305777066145, 5841.094630332305, 5849.502792262535, 5852.94147058541, 5854.063349864001, 5681.0910254359105, 5805.82582522525, 5862.706864656835, 5863.91517569251, 5865.090910908816, 5733.913991290051, 5738.626989245686, 5741.655500669973, 5746.367899531132, 5746.798862039976, 5808.970955145197, 5836.270466191726, 5836.445537673914, 5836.678982655994, 5847.707614619337, 5666.886662266649, 5688.488036076773, 5694.06048002075, 5711.057675483498, 5716.657000579979], "value": 5522.70339179847, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.4716934956224, 483.4609410507284, 495.3263561556285, 501.5937090956325, 529.5578192209505, 37482.62517374825, 38510.0, 38670.41994370083, 38911.22177556454, 41055.58944410555, 39649.801750991275, 40215.59784402163, 40333.39499907504, 40376.99057523556, 40514.59485405145, 7325.597092159929, 9302.441853488795, 9469.443250322409, 9482.146606805387, 9489.00365461627, 8368.497890126582, 8516.23353898149, 8541.95729021354, 8545.444546104514, 8547.829043419128, 11184.776304473906, 11448.198626096177, 11499.712507187303, 11609.825852612217, 11616.36110013949, 11215.495302711397, 11342.943285283603, 11343.773124537463, 11348.205625606211, 11353.943230283878, 8300.958495207486, 8518.148185181495, 8533.14668533148, 11196.440177991068, 11287.717807054807, 30640.92756753525, 31049.06852794397, 37399.4390084149, 37932.81033594815, 37979.24041519154, 3301.818399988, 3446.7070299024613, 3811.5997820228754, 3866.2074274773886, 3872.956646231054, 28433.0, 28992.71007289921, 29010.854945725347, 29062.27344316388, 29116.854415727998, 3051.435940677559, 3197.600299962505, 3239.7732158748895, 3249.69127932846, 3309.7517686173633, 322878.0, 329618.0, 332465.0, 333316.0, 333501.0, 55797.442025580036, 56091.0, 56198.43801562014, 56236.0, 56332.718336408056, 55236.0, 59231.40768592345, 59364.70317648384, 59466.70266648639, 59509.404905951254, 15437.382504699686, 15650.68698626021, 15656.373745050298, 15657.0, 15695.372185112468, 12094.334811585271, 12147.785221477958, 12151.5139394425, 12161.574344897886, 12173.330466824409, 14103.717925641635, 14407.0, 15790.526284211492, 16099.517014489584, 16135.0, 4661.13350723263, 5298.311219541435, 5881.235439392852, 5999.100134979701, 6036.279660296795, 882.6248844241172, 890.2077151335317, 1017.6489111256604, 1060.3213943076437, 1083.5340803454433, 28112.71887281101, 28251.293717657223, 28421.289467763472, 28494.927557790157, 28787.85606071998, 1079.1151255970185, 1090.4765712457906, 1161.517970042423, 1187.827764974074, 1191.368574655434, 13962.441502339996, 14566.927165364104, 14601.853981460263, 14950.775738363933, 15004.699906001819, 525281.0, 535919.0, 538450.0, 539317.0, 540319.0, 54050.72974635102, 54134.72932635312, 54241.0, 54328.0, 54408.63978400572, 1195.2529668956902, 1232.796588562895, 1291.231717128307, 1327.5419980106847, 1340.805583190432, 28320.71679283181, 28474.0, 29441.85279073591, 29449.85275073611, 30232.941847035247, 42904.57095429006, 43195.78402107969, 43315.56684433115, 43324.35013474737, 43379.0, 412209.0, 416878.0, 419648.0, 422254.0, 425250.0, 24833.379165521008, 25506.74493255044, 26142.86928565345, 26349.86825065939, 36746.63253367432, 42534.93662658458, 43405.0, 43600.0, 44102.55897441113, 44199.33700994423, 35872.820635896656, 36111.45832812563, 36214.8189259052, 37033.44449833308, 37224.441633374976, 30441.39117217599, 36063.27873442569, 36644.81677591595, 36955.63044369522, 37424.438633421065, 34928.0, 35660.64339356677, 36252.63747362598, 36350.63649363472, 36459.0, 31418.52872206873, 32416.35167296688, 32535.861244856318, 32675.509867351535, 33154.52413924089, 21921.232756853435, 23748.050077997377, 23877.044918203774, 24087.397815054763, 24619.50760984806], "value": 18710.11636803423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.6658725521045, 337.67920475548226, 369.1988385204107, 374.08536129164196, 395.4819186865205, 14876.033057851231, 15164.545063648095, 19508.0, 19925.99999999998, 20804.0, 19690.212391504323, 20189.39431817044, 20234.59530809383, 20236.494087647818, 20501.38495845127, 5671.943280567193, 5984.102384642295, 6000.789972350969, 6007.038873780196, 6027.126066720323, 5825.533957283407, 5843.64938103713, 5884.411558844103, 5885.823425297226, 5890.499307558863, 5262.81580144695, 5831.746174572466, 5906.0, 5920.437558431942, 5926.911096333559, 5641.351244606841, 5759.107338362561, 5823.679697616651, 5842.182094506772, 5881.558883083764, 5106.719130447824, 5107.004134193834, 5111.795528178868, 5114.002769459957, 5119.692818430869, 24549.263522094367, 25205.243842684748, 25245.242642720747, 25255.747442525524, 25379.604121773296, 2022.48426651203, 2233.3634914049417, 2246.9550608987893, 2270.943226419336, 2328.5110126873205, 10220.97790220972, 10343.741406464898, 12650.304233267167, 13523.932380338134, 14209.289535523287, 1816.8909865408118, 1848.3068849181557, 1861.8696691231619, 1915.6101426307475, 1918.7697476302933, 80923.38153236962, 112975.87024129818, 113015.43492282568, 113665.4316728411, 115143.0, 10489.423081730578, 10663.360198388122, 10701.571937122584, 11248.606298779503, 11454.911783380565, 14142.151470911778, 14368.353424095942, 14381.856181438261, 14401.0, 14408.20754858493, 7818.452708310364, 7865.499852565554, 8289.171082891784, 8391.748247552583, 8394.8321033579, 8146.67413303473, 8166.305864001626, 8169.5098294102545, 8330.541820199947, 8352.0, 3743.2139250757646, 4381.824727010948, 4439.156560253606, 4517.751523666164, 4566.406367172246, 1641.7209074457132, 1672.8410800973888, 1906.4566598519632, 1938.7479627648597, 1960.304092047331, 840.7687885831446, 909.9671872424714, 916.6287653500343, 963.889152747429, 1021.0861279155115, 18979.71530427045, 20735.377938661863, 20803.68794468084, 20852.0, 20983.265585704426, 910.2126660438805, 925.5141050948306, 931.500284541887, 934.1545900959643, 938.2494004796135, 10288.91053012707, 10946.332978452308, 11081.947215014561, 11154.0, 11160.832587511193, 400508.0, 460996.0, 462896.0, 465354.0, 465819.0, 93551.0, 106353.0, 115059.0, 117705.0, 123097.38451307865, 967.9661211857551, 969.5007071358115, 1001.4492029383955, 1026.1380440430075, 1027.6146445083093, 17679.73480397821, 18401.539961500534, 18476.983765892466, 18479.53801154982, 18492.81507184911, 49593.752031239615, 49885.75057124836, 50437.0, 51076.0, 51815.704607385116, 70578.89303581338, 70616.6469167651, 72675.90986135318, 72932.0, 73047.0, 6781.152355955505, 7053.753118640823, 7103.076600041962, 7134.788215653164, 7222.638868056471, 8939.642414303615, 11781.882181178078, 11869.228500147463, 12229.388530573258, 12454.439550220442, 10389.844152337871, 10657.520411581343, 10743.24797264184, 10796.946015269874, 10869.29349592274, 5604.915926261191, 10373.325733827278, 10505.842412363974, 10803.513841876977, 10913.618023369145, 10197.0, 10296.639617613648, 10322.277440579388, 10949.0, 11211.943940280247, 5857.560682948882, 6994.160700715743, 7029.0, 7193.244709305657, 7218.242084581043, 8897.91102088971, 10061.694837483588, 10224.897751022692, 10463.162946964378, 10585.8941410588], "value": 9105.997549636159, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.128765658494, 1485.5469081930007, 1510.9093454392737, 1690.4759524547383, 1864.0679660169906, 6774.390304872567, 7363.595002274873, 7762.223777622249, 7787.0, 7787.22127787221, 7884.408669349793, 8172.673093076285, 8191.221833925782, 8240.093589705128, 8255.793605159874, 2258.6160352740076, 2284.942876428086, 2293.919712810052, 2293.9541209175804, 2296.42589352661, 2272.988635056822, 2307.0886999635136, 2338.462153704649, 2342.81687747688, 2346.3547524430746, 2284.5316710074394, 2290.564792689392, 2316.988415057931, 2319.976800231993, 2325.430269583954, 2259.3334966184852, 2278.259565641165, 2289.061484791236, 2299.862008279492, 2301.861888286708, 2304.896279667419, 2316.6409206573007, 2318.2929206591984, 2321.651752237178, 2329.801966832821, 8152.225538573885, 8291.170882911721, 8303.501789892565, 8311.750647480585, 8319.916800831974, 4946.629002824767, 5009.0482808266315, 5146.433892271847, 5175.948240517584, 5182.792688292464, 3336.5996080470254, 3505.439129739255, 3594.622564630702, 3599.5523044329843, 3605.5853576838476, 1047.5076713944434, 1074.75280685442, 1090.6237348114887, 1091.6015654286127, 1096.1504833753825, 10241.795164096751, 10437.2172087093, 10606.78786424275, 10612.991765782239, 10788.784224315548, 3805.8858234253016, 4465.37484752135, 4633.7683115844075, 4669.673122881366, 4672.486026537078, 9370.90629093714, 9371.297152713574, 9375.24998000172, 9386.202172815387, 9390.67132650354, 5119.769610367543, 5160.870978225575, 5170.146925757208, 5183.637145399785, 5183.766730497136, 3994.6205110514456, 4255.3616957456625, 4375.387445757597, 4401.6478681705385, 4766.261229509431, 3355.8757816131383, 3670.376036073874, 3737.271232109767, 3757.3800322946954, 3815.5802861685193, 1247.731737676404, 1266.7656483550572, 1269.571731801723, 1287.0540152987546, 1287.9613611591667, 836.6277006732067, 843.9493630382074, 882.166352796601, 889.8531742262454, 930.3766476460787, 5431.4840090191365, 5445.237666726662, 5590.776368945278, 5601.467860553241, 5830.970845145747, 786.2373497707215, 906.7687739626485, 964.62379671928, 975.4098770244042, 980.6959842448864, 3553.3959226931483, 3768.773873567595, 3774.6602805747066, 3788.791616461121, 3843.481130047464, 9624.615015399306, 9942.652007179713, 10021.29850910444, 10035.949820250851, 10042.598296068221, 9208.539573021322, 9972.501374931224, 9985.750356241153, 10001.79996400068, 10043.146332561813, 7493.775186744407, 7718.768436946901, 7719.536827790351, 7731.188225236269, 7743.264389882952, 4557.658175636907, 5467.890642187213, 5565.888682226414, 5666.858328541819, 5715.371309155907, 8966.879140107487, 9113.04313047147, 9124.49815260167, 9224.631014759334, 9343.252539796664, 7388.448425830421, 9250.444973301623, 9324.533773311443, 9453.0, 9464.621415143318, 6969.059177011241, 7120.501564890616, 7134.964325178341, 7136.143662760502, 7161.2122666507685, 7475.962620186864, 7639.77080687558, 7730.226977302224, 7737.961310193413, 7765.029371328584, 6951.895721564281, 6975.0, 7011.614361210182, 7047.506674532733, 7166.817475116756, 6872.347127022925, 6895.6552172390175, 6917.342852429011, 6922.169339679271, 6979.092717946634, 6503.414692677493, 6509.967450162909, 6577.112089867998, 6583.341665833378, 6592.67036648156, 4600.240960241523, 4650.441946966385, 4712.670113092187, 4750.429948406213, 4850.345203397496, 4165.4168416422335, 4688.5545873142, 4828.37231159947, 4878.658493905393, 4933.975330123327], "value": 4354.610394318128, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [254.37297062740348, 296.3465558443633, 301.0801999890334, 309.37814991866355, 312.7826160818232, 4403.163398954204, 4601.102784956935, 4894.5594896459315, 4961.87595310117, 4982.676126051809, 3860.2086572252692, 4008.8997775055636, 4332.740035597866, 4677.672562920597, 4840.7579621018895, 3841.5774264830848, 3868.0, 3878.3019056569806, 3880.4373365861934, 3881.156450685916, 3416.692497675209, 3535.3636345457808, 3861.4980052593123, 3864.4396562498423, 3888.2806680764006, 3237.7247933925646, 3262.3801477719276, 3607.5310209672707, 3630.5824830144606, 3854.4603755474254, 3381.7970921744527, 3466.653334666526, 3837.884863454101, 3863.265979463907, 3867.2265546890735, 2948.6019387382644, 3065.371598822236, 3309.321589074234, 3313.9834300828584, 3384.8984530464127, 4873.415190177166, 4893.657443978923, 4895.363602731658, 4896.583790377822, 4945.53017463344, 3848.826802793881, 3980.1641655252433, 4268.509121451011, 4297.634701050414, 4306.7631280279575, 5156.278121063054, 5175.120229560984, 5183.067047931371, 5209.400918894337, 5223.921641175385, 3604.585472670624, 3625.6374362563797, 3631.837811900193, 3638.653068770628, 3641.326354624403, 5036.298320734258, 5150.995555866645, 5371.791346946906, 5375.2261753621215, 5446.809361672362, 3380.9323813523592, 3558.1282585766653, 3660.3228402745576, 3663.6336366363685, 3690.28039532294, 3697.98305465999, 3708.1841994761107, 3717.3308804415465, 3727.2481933491217, 3744.2885851688093, 4264.253755592759, 4269.829206831692, 4287.0, 4292.957070429318, 4293.162833247549, 4919.065377578248, 5183.092958732207, 5191.9480805192225, 5228.006678731029, 5228.183426098969, 1170.7248796532808, 1195.4739914437619, 1198.3948106206485, 1201.7167381974318, 1212.2605210821391, 663.3731124087788, 705.9152901651835, 817.5013241922422, 824.6701319472259, 830.4021104804531, 3916.6475017248586, 4553.385292985405, 4897.681650692693, 4944.626579241984, 4953.702777833341, 5365.283109404953, 5381.165919282517, 5387.299651045339, 5413.458654134633, 5416.891662166813, 4010.47863777707, 4338.240807858612, 4911.361523002059, 4911.557959783637, 5058.002089174829, 2288.4736510602656, 2374.45387560862, 2417.045267119478, 2516.5721827289403, 2673.5321318769525, 4684.149760844447, 4749.810007599726, 5085.95737873735, 5217.713025783542, 5327.254184414185, 4610.101030299126, 4634.914288570157, 4925.458199598042, 5033.612149137423, 5117.769700363493, 4937.247691754221, 4997.975010124999, 5233.973830130977, 5241.554467870274, 5294.497022782906, 4328.502222244482, 4747.8575642730775, 5018.372703412074, 5061.836926335044, 5234.476552344735, 4274.829006839816, 4710.905781884275, 4884.535969082932, 4976.776045078052, 4978.726170060681, 4706.929396058993, 5090.54919347984, 5240.3492899737985, 5267.2889159962915, 5270.314859068297, 3515.3616007432183, 3550.1479644885558, 3577.856885724542, 3585.8924232273075, 3611.0, 4616.099860527165, 4775.808967641256, 4814.398200224972, 5019.297298378303, 5036.445990940921, 4250.36244563318, 4373.707813545645, 4379.58393952574, 4741.217699079752, 4980.850574482626, 4019.618136277049, 4277.037666525007, 4818.95181048185, 4885.413750349981, 4915.787895447134, 4261.95738042628, 4728.115849331974, 4748.976255118702, 4761.095561775318, 4772.284157376422, 4507.746126936532, 4514.503404625423, 4686.507916668701, 4873.6832105913, 4882.707037577757, 4100.138970816042, 4110.253142414402, 4211.810468528863, 4698.110661942949, 4739.398057476274], "value": 3702.7423224621525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.1631568696973, 676.3777324861127, 679.8742232686951, 761.1018997582853, 771.1363273134089, 13678.589642310733, 14493.260808702957, 15479.07125572465, 16292.75560866585, 16380.0, 14884.25578721065, 15035.398584056651, 15231.086134831918, 15308.770368444482, 15459.0, 816.9550674712889, 840.861257892447, 842.9199226073513, 843.6245870587591, 844.8437039147777, 655.0501772429972, 678.6572780745716, 832.4505826154739, 840.474703310431, 840.9957950210271, 719.1118968074423, 845.8477474054667, 870.6473878079388, 878.995605021974, 886.7650072730731, 878.7319867440428, 879.9692010779656, 880.5817236812463, 881.6385282034336, 882.8940527136721, 511.7057691827177, 648.1865259099847, 649.1723053107279, 649.2987573420694, 650.2911826109563, 11975.281483110954, 13726.862731372657, 14302.642433939234, 14369.712605747827, 14667.266636668124, 12829.0, 13042.347882605833, 13237.205767653972, 13303.600891973256, 13314.334283285894, 9454.669086581936, 10969.725756856064, 11283.37941413222, 11328.830067548994, 11831.112666549958, 3605.56733192016, 3702.092987218122, 3716.9442458363146, 3800.4869342638945, 3840.0783811885226, 78689.60655196688, 78892.60553697195, 79865.0, 79923.60038199772, 80137.59931200364, 10338.948305258426, 10393.740156495996, 10394.792104157874, 10564.683059508227, 10809.35143891369, 19614.21543138287, 19634.0, 19652.017399129985, 19655.606887862163, 19669.11488982999, 7022.964885175541, 7127.964360178166, 7131.643417829087, 7145.4640901931525, 7619.390448764086, 4276.91446171081, 4409.911801764011, 4428.180786554498, 4540.84107056258, 4557.430321209848, 3393.2365217826286, 3467.930641387158, 3516.8065756383644, 3518.1204698825295, 3522.1546828761425, 659.6833519910374, 660.6762686283687, 692.1866806502339, 710.1832892173938, 717.8851383778571, 579.8637320229743, 588.5703436491385, 602.235161345098, 662.159057996342, 666.9899951500731, 8123.228293312126, 8536.658533658709, 9136.543172841331, 9592.424454532751, 9646.131848133702, 594.378874076591, 606.3269770554681, 673.6631684157921, 677.8881484555092, 699.140057728986, 4129.380592911088, 4150.232207041707, 4316.223079845595, 4389.978050109729, 4475.082608065339, 95423.0, 96517.51741241249, 97640.5287921141, 98183.01816981738, 101695.0, 68215.65892170508, 70924.0, 85733.0, 89829.55085224663, 90028.5498572503, 70499.0, 70670.58658826795, 71483.92774108393, 72775.90836137462, 73973.0, 9121.0, 9324.860127098234, 9365.859512107187, 9376.531173441164, 9401.482918439551, 43749.0, 43901.46344877914, 46559.0, 49196.50803491919, 50560.494395055575, 50169.0, 66937.99593006012, 70789.29210707828, 72752.0, 73155.17112072241, 11383.601573944872, 11518.481668325114, 11879.881201188224, 11959.820602691141, 12265.570705025639, 11868.76262474763, 13216.867831321564, 13538.0, 13761.348638163485, 13773.655658608615, 10037.0, 12771.297578633264, 12862.742745144858, 13342.06605537642, 13379.397927093109, 11232.3260604364, 12585.811212831632, 12801.93599031999, 13145.474181032652, 13447.394867230802, 10771.407572583583, 12380.504779808707, 12931.22412655206, 13045.934770326088, 13050.54323098687, 9008.954955225181, 10936.234463587472, 10950.06924411402, 11015.339079655247, 11320.547178113113, 9854.497682373816, 10932.0, 10980.945095274472, 11137.276077054965, 11174.608888688857], "value": 7090.961252937461, "unit": "score"}], "name": "dromaeo_css", "value": 6896.5295369403, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 159.0, 163.0, 111.0, 111.0, 113.0, 113.0, 112.0, 111.0, 111.0], "value": 120.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 110.0, 170.0, 119.0, 113.0, 112.0, 107.0, 144.0, 102.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 185.0, 184.0, 184.0, 183.0, 183.0, 180.0, 181.0, 182.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 87.0, 59.0, 58.0, 58.0, 58.0, 81.0, 59.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 91.0, 70.0, 69.0, 69.0, 89.0, 67.0, 70.0, 92.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 85.0, 89.0, 122.0, 88.0, 85.0, 87.0, 85.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 99.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 85.0, 86.0, 87.0, 86.0, 94.0, 131.0, 111.0, 85.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 57.0, 54.0, 54.0, 55.0, 53.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 72.0, 79.0, 73.0, 71.0, 71.0, 71.0, 71.0, 70.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 87.0, 88.0, 87.0, 86.0, 86.0, 85.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 160.0, 159.0, 165.0, 146.0, 161.0, 156.0, 204.0, 172.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 173.0, 171.0, 176.0, 199.0, 173.0, 198.0, 225.0, 178.0], "value": 183.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 69.0, 81.0, 84.0, 85.0, 69.0, 66.0], "value": 72.4, "unit": "score"}], "name": "kraken", "value": 1481.7000000000003, "alertThreshold": 2.0}]} 22:20:22 INFO - Return code: 0 22:20:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:20:22 INFO - # TBPL SUCCESS # 22:20:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:20:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:20:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:20:22 INFO - 2016-11-17 22:20:22.953 screenresolution[1919:19951] starting screenresolution argv=screenresolution get 22:20:22 INFO - 2016-11-17 22:20:22.955 screenresolution[1919:19951] Display 0: 1600x1200x32@60 22:20:22 INFO - 2016-11-17 22:20:22.961 screenresolution[1920:19954] starting screenresolution argv=screenresolution list 22:20:22 INFO - Available Modes on Display 0 22:20:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:20:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:20:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:20:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:20:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:20:23 INFO - Intel Iris: 22:20:23 INFO - Chipset Model: Intel Iris 22:20:23 INFO - Type: GPU 22:20:23 INFO - Bus: Built-In 22:20:23 INFO - VRAM (Dynamic, Max): 1536 MB 22:20:23 INFO - Vendor: Intel (0x8086) 22:20:23 INFO - Device ID: 0x0a2e 22:20:23 INFO - Revision ID: 0x0009 22:20:23 INFO - Displays: 22:20:23 INFO - Display: 22:20:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:20:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:20:23 INFO - Display Serial Number: 1600x1200 60 22:20:23 INFO - Main Display: Yes 22:20:23 INFO - Mirror: Off 22:20:23 INFO - Online: Yes 22:20:23 INFO - Rotation: Supported 22:20:23 INFO - Return code: 0 22:20:23 INFO - Running post-action listener: _resource_record_post_action 22:20:23 INFO - [mozharness: 2016-11-18 06:20:23.202272Z] Finished run-tests step (success) 22:20:23 INFO - Running post-run listener: _resource_record_post_run 22:20:23 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 569344; Write bytes: 688800768; Read time: 6; Write time: 1942 22:20:23 INFO - TinderboxPrint: CPU usage
53.8% 22:20:23 INFO - TinderboxPrint: I/O read bytes / time
569,344 / 6 22:20:23 INFO - TinderboxPrint: I/O write bytes / time
688,800,768 / 1,942 22:20:23 INFO - TinderboxPrint: CPU idle
2,242.6 (46.2%) 22:20:23 INFO - TinderboxPrint: CPU system
975.9 (20.1%) 22:20:23 INFO - TinderboxPrint: CPU user
1,639.2 (33.7%) 22:20:23 INFO - TinderboxPrint: Swap in / out
383,557,632 / 0 22:20:23 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 362252800; Write bytes: 357668864; Read time: 27715; Write time: 736 22:20:23 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 569344; Write bytes: 301755392; Read time: 6; Write time: 1132 22:20:23 INFO - Running post-run listener: _upload_blobber_files 22:20:23 INFO - Blob upload gear active. 22:20:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:20:23 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 22:20:23 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:20:23 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:20:24 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:20:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:20:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:24 INFO - (blobuploader) - INFO - Done attempting. 22:20:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:20:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:20:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:25 INFO - (blobuploader) - INFO - Done attempting. 22:20:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:20:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:20:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:27 INFO - (blobuploader) - INFO - Done attempting. 22:20:27 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:27 INFO - Return code: 0 22:20:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:20:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a91d639dea56bd90f0275237baa8944c1dcc233f00388e517e8623ddec9c96c4077eb5f939f3edd90b7a511abfa3f7a3ec05f01c6afadb1e1f4fee5fdfa171f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53fa34aa8ba0c4aa10666446fc3ae4d4d0720b22b205afef3b975910d1acddc34123a5835e9832ec8457782deb43e389a871a896bff0292292f90f1452b07109", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cec4f0ac66630ba3ed8ba4ea11b454f016cb478ee1e737c2f9e77859205e4cc65bc6fe6b6c7aa02f95a62cef9f39ab9fb46157e644a5f1e052e195c31ae6e804"} 22:20:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:20:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:20:27 INFO - Contents: 22:20:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a91d639dea56bd90f0275237baa8944c1dcc233f00388e517e8623ddec9c96c4077eb5f939f3edd90b7a511abfa3f7a3ec05f01c6afadb1e1f4fee5fdfa171f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53fa34aa8ba0c4aa10666446fc3ae4d4d0720b22b205afef3b975910d1acddc34123a5835e9832ec8457782deb43e389a871a896bff0292292f90f1452b07109", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cec4f0ac66630ba3ed8ba4ea11b454f016cb478ee1e737c2f9e77859205e4cc65bc6fe6b6c7aa02f95a62cef9f39ab9fb46157e644a5f1e052e195c31ae6e804"} 22:20:27 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:27 INFO - Copying logs to upload dir... 22:20:27 INFO - mkdir: /builds/slave/test/build/upload/logs 22:20:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.383251 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-17 22:20:27.827835) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 22:20:27.830901) ========= 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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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/Firefox/sha512/a91d639dea56bd90f0275237baa8944c1dcc233f00388e517e8623ddec9c96c4077eb5f939f3edd90b7a511abfa3f7a3ec05f01c6afadb1e1f4fee5fdfa171f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53fa34aa8ba0c4aa10666446fc3ae4d4d0720b22b205afef3b975910d1acddc34123a5835e9832ec8457782deb43e389a871a896bff0292292f90f1452b07109", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cec4f0ac66630ba3ed8ba4ea11b454f016cb478ee1e737c2f9e77859205e4cc65bc6fe6b6c7aa02f95a62cef9f39ab9fb46157e644a5f1e052e195c31ae6e804"} build_url:https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011019 build_url: 'https://queue.taskcluster.net/v1/task/NPzjYRK3SQuLY4wedYXUlQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a91d639dea56bd90f0275237baa8944c1dcc233f00388e517e8623ddec9c96c4077eb5f939f3edd90b7a511abfa3f7a3ec05f01c6afadb1e1f4fee5fdfa171f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53fa34aa8ba0c4aa10666446fc3ae4d4d0720b22b205afef3b975910d1acddc34123a5835e9832ec8457782deb43e389a871a896bff0292292f90f1452b07109", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cec4f0ac66630ba3ed8ba4ea11b454f016cb478ee1e737c2f9e77859205e4cc65bc6fe6b6c7aa02f95a62cef9f39ab9fb46157e644a5f1e052e195c31ae6e804"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 22:20:27.863076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 22:20:27.863370) ========= 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.qOaRzlfnRf/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.Xt5VwePfyS/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.005143 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 22:20:27.911109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 22:20:27.911405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 22:20:27.911707) ========= ========= Total master_lag: 0.17 =========