builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0137 starttime: 1476751070.91 results: success (0) buildid: 20161017151219 builduid: b1454f2e38c9443aa401621025f16bda revision: 07e27ed94ad03941605d4f508695215f85c2b1a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:50.909867) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:50.910331) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:50.910616) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:50.933159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:50.933435) ========= 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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-17 17:37:50-- 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% 143M=0s 2016-10-17 17:37:51 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:51.045565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:51.048931) ========= 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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.019889 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:51.097670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 17:37:51.098031) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 07e27ed94ad03941605d4f508695215f85c2b1a4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 07e27ed94ad03941605d4f508695215f85c2b1a4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-17 17:37:51,169 truncating revision to first 12 chars 2016-10-17 17:37:51,169 Setting DEBUG logging. 2016-10-17 17:37:51,170 attempt 1/10 2016-10-17 17:37:51,170 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/07e27ed94ad0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 17:37:52,161 unpacking tar archive at: larch-07e27ed94ad0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.276382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 17:37:52.396554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:52.396890) ========= script_repo_revision: 07e27ed94ad03941605d4f508695215f85c2b1a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:52.397261) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:52.397525) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 17:37:52.416903) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-17 17:37:52.417524) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:37:52 INFO - MultiFileLogger online at 20161017 17:37:52 in /builds/slave/test 17:37:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 17:37:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:37:52 INFO - {'append_to_log': False, 17:37:52 INFO - 'base_work_dir': '/builds/slave/test', 17:37:52 INFO - 'blob_upload_branch': 'Larch', 17:37:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:37:52 INFO - 'branch': 'Larch', 17:37:52 INFO - 'buildbot_json_path': 'buildprops.json', 17:37:52 INFO - 'config_files': ('talos/mac_config.py',), 17:37:52 INFO - 'default_actions': ('clobber', 17:37:52 INFO - 'read-buildbot-config', 17:37:52 INFO - 'download-and-extract', 17:37:52 INFO - 'populate-webroot', 17:37:52 INFO - 'create-virtualenv', 17:37:52 INFO - 'install', 17:37:52 INFO - 'run-tests'), 17:37:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:37:52 INFO - 'download_minidump_stackwalk': True, 17:37:52 INFO - 'download_symbols': 'ondemand', 17:37:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:37:52 INFO - 'tooltool.py': '/tools/tooltool.py', 17:37:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:37:52 INFO - '/tools/misc-python/virtualenv.py')}, 17:37:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:37:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:37:52 INFO - 'installer_path': 'installer.exe', 17:37:52 INFO - 'log_level': 'info', 17:37:52 INFO - 'log_name': 'talos', 17:37:52 INFO - 'log_to_console': True, 17:37:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:37:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:37:52 INFO - 'opt_config_files': (), 17:37:52 INFO - 'pip_index': False, 17:37:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:37:52 INFO - 'cmd': ('bash', 17:37:52 INFO - '-c', 17:37:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:37:52 INFO - 'enabled': True, 17:37:52 INFO - 'halt_on_failure': False, 17:37:52 INFO - 'name': 'check_screen_resolution'},), 17:37:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:37:52 INFO - 'cmd': ('bash', 17:37:52 INFO - '-c', 17:37:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:37:52 INFO - 'enabled': True, 17:37:52 INFO - 'halt_on_failure': False, 17:37:52 INFO - 'name': 'check_screen_resolution'},), 17:37:52 INFO - 'run_cmd_checks_enabled': True, 17:37:52 INFO - 'sps_profile': False, 17:37:52 INFO - 'sps_profile_interval': 0, 17:37:52 INFO - 'suite': 'dromaeojs', 17:37:52 INFO - 'system_bits': '32', 17:37:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:37:52 INFO - 'title': 't-yosemite-r7-0137', 17:37:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:37:52 INFO - 'use_talos_json': True, 17:37:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:37:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:37:52 INFO - 'work_dir': 'build'} 17:37:52 INFO - [mozharness: 2016-10-18 00:37:52.616254Z] Running clobber step. 17:37:52 INFO - Running pre-action listener: _resource_record_pre_action 17:37:52 INFO - Running main action method: clobber 17:37:52 INFO - rmtree: /builds/slave/test/build 17:37:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:37:54 INFO - Running post-action listener: _resource_record_post_action 17:37:54 INFO - [mozharness: 2016-10-18 00:37:54.114015Z] Finished clobber step (success) 17:37:54 INFO - [mozharness: 2016-10-18 00:37:54.114147Z] Running read-buildbot-config step. 17:37:54 INFO - Running pre-action listener: _resource_record_pre_action 17:37:54 INFO - Running main action method: read_buildbot_config 17:37:54 INFO - Using buildbot properties: 17:37:54 INFO - { 17:37:54 INFO - "project": "", 17:37:54 INFO - "product": "firefox", 17:37:54 INFO - "script_repo_revision": "production", 17:37:54 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 17:37:54 INFO - "repository": "", 17:37:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 17:37:54 INFO - "buildid": "20161017151219", 17:37:54 INFO - "pgo_build": "False", 17:37:54 INFO - "basedir": "/builds/slave/test", 17:37:54 INFO - "buildnumber": 2, 17:37:54 INFO - "slavename": "t-yosemite-r7-0137", 17:37:54 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 17:37:54 INFO - "platform": "yosemite_r7", 17:37:54 INFO - "scheduler": "tests-larch-macosx64-talos", 17:37:54 INFO - "branch": "larch", 17:37:54 INFO - "repo_path": "projects/larch", 17:37:54 INFO - "revision": "07e27ed94ad03941605d4f508695215f85c2b1a4", 17:37:54 INFO - "stage_platform": "macosx64", 17:37:54 INFO - "builduid": "b1454f2e38c9443aa401621025f16bda", 17:37:54 INFO - "slavebuilddir": "test" 17:37:54 INFO - } 17:37:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 17:37:54 INFO - Running post-action listener: _resource_record_post_action 17:37:54 INFO - [mozharness: 2016-10-18 00:37:54.117453Z] Finished read-buildbot-config step (success) 17:37:54 INFO - [mozharness: 2016-10-18 00:37:54.117563Z] Running download-and-extract step. 17:37:54 INFO - Running pre-action listener: _resource_record_pre_action 17:37:54 INFO - Running main action method: download_and_extract 17:37:54 INFO - mkdir: /builds/slave/test/build/tests 17:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:54 INFO - trying https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 17:37:54 INFO - Downloading https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 17:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 17:37:55 INFO - Downloaded 1199 bytes. 17:37:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 17:37:55 INFO - Using the following test package requirements: 17:37:55 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:37:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 17:37:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 17:37:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'jsshell-mac.zip'], 17:37:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 17:37:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:37:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 17:37:55 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 17:37:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 17:37:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:37:55 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 17:37:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:37:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:37:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:37:55 INFO - Fetch https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:37:55 INFO - Http code: 200 17:37:55 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 17:37:55 INFO - x-amz-cf-id: Euwo5grz9VtuRKO4SUT610BdZE-vSHqo0WofV1zLfiD3frxnCq2eGw== 17:37:55 INFO - x-amz-version-id: iqr_qa.36.J15DINAAKGh2bbX0qVJOq3 17:37:56 INFO - Expected file size: 16508476 17:37:56 INFO - Obtained file size: 16508476 17:38:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:38:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:38:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:38:02 INFO - Fetch https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:38:03 INFO - Http code: 200 17:38:03 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 17:38:03 INFO - x-amz-cf-id: Jxt0R-NcTPLAypQjrUhSsjDw8MojurBtUiNj0UH46A2vLz8uD3wpTQ== 17:38:03 INFO - x-amz-version-id: iqr_qa.36.J15DINAAKGh2bbX0qVJOq3 17:38:03 INFO - Expected file size: 16508476 17:38:03 INFO - Obtained file size: 16508476 17:38:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 17:38:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:38:09 INFO - Fetch https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 17:38:11 INFO - Http code: 200 17:38:11 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 17:38:11 INFO - x-amz-cf-id: thzStYPsfkF_hEW0PojNcA_OJKInluKsfVbQuiiZ1srikvi4QsuOzA== 17:38:11 INFO - x-amz-version-id: zt4fpGik5HS288uRyk01.8msPELnAIH8 17:38:11 INFO - Expected file size: 14409006 17:38:11 INFO - Obtained file size: 14409006 17:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:11 INFO - trying https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:38:11 INFO - Downloading https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 17:38:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 17:38:14 INFO - Downloaded 111664616 bytes. 17:38:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:38:14 INFO - mkdir: /builds/slave/test/properties 17:38:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:38:14 INFO - Writing to file /builds/slave/test/properties/build_url 17:38:14 INFO - Contents: 17:38:14 INFO - build_url:https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:38:15 INFO - Running post-action listener: _resource_record_post_action 17:38:15 INFO - Running post-action listener: set_extra_try_arguments 17:38:15 INFO - [mozharness: 2016-10-18 00:38:15.111876Z] Finished download-and-extract step (success) 17:38:15 INFO - [mozharness: 2016-10-18 00:38:15.111999Z] Running populate-webroot step. 17:38:15 INFO - Running pre-action listener: _resource_record_pre_action 17:38:15 INFO - Running main action method: populate_webroot 17:38:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:38:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:38:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:38:15 INFO - '--tppagecycles', 17:38:15 INFO - '7'], 17:38:15 INFO - 'tests': ['tsvgm']}}, 17:38:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:38:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:38:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:38:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:38:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['damp', 'tps']}, 17:38:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'tests': ['damp', 'tps']}, 17:38:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['dromaeo_dom']}, 17:38:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:38:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['basic_compositor_video']}, 17:38:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:38:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'other-e10s': {'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['a11yr', 17:38:15 INFO - 'ts_paint', 17:38:15 INFO - 'tpaint', 17:38:15 INFO - 'sessionrestore', 17:38:15 INFO - 'sessionrestore_no_auto_restore', 17:38:15 INFO - 'tabpaint']}, 17:38:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['tsvgx', 17:38:15 INFO - 'tsvgr_opacity', 17:38:15 INFO - 'tart', 17:38:15 INFO - 'tscrollx', 17:38:15 INFO - 'cart']}, 17:38:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:38:15 INFO - 'tsvgr_opacity', 17:38:15 INFO - 'tart', 17:38:15 INFO - 'tscrollx', 17:38:15 INFO - 'cart']}, 17:38:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'talos_options': ['--disable-e10s'], 17:38:15 INFO - 'tests': ['tp5o']}, 17:38:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'tests': ['tp5o']}, 17:38:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'talos_options': ['--disable-e10s', 17:38:15 INFO - '--xperf_path', 17:38:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:15 INFO - 'tests': ['tp5n']}, 17:38:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:15 INFO - 'talos_options': ['--xperf_path', 17:38:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:15 INFO - 'tests': ['tp5n']}}, 17:38:15 INFO - 'talos.zip': {'path': '', 17:38:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:38:15 INFO - Running post-action listener: _resource_record_post_action 17:38:15 INFO - [mozharness: 2016-10-18 00:38:15.130823Z] Finished populate-webroot step (success) 17:38:15 INFO - [mozharness: 2016-10-18 00:38:15.130952Z] Running create-virtualenv step. 17:38:15 INFO - Running pre-action listener: _resource_record_pre_action 17:38:15 INFO - Running main action method: create_virtualenv 17:38:15 INFO - Creating virtualenv /builds/slave/test/build/venv 17:38:15 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 17:38:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:38:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:38:15 INFO - Using real prefix '/tools/python27' 17:38:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:38:15 INFO - Installing distribute.............................................................................................................................................................................................done. 17:38:18 INFO - Installing pip.................done. 17:38:18 INFO - Return code: 0 17:38:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:38:19 INFO - Reading from file tmpfile_stdout 17:38:19 INFO - Output received: 17:38:19 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) 17:38:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:38:19 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')]} 17:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 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')]} 17:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 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 0x10dd17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8aa4d4730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, '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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:38:19 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 17:38:19 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 17:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:19 INFO - 'HOME': '/Users/cltbld', 17:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:19 INFO - 'LOGNAME': 'cltbld', 17:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:19 INFO - 'MOZ_NO_REMOTE': '1', 17:38:19 INFO - 'NO_EM_RESTART': '1', 17:38:19 INFO - 'PAGER': '/bin/cat', 17:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:19 INFO - 'PWD': '/builds/slave/test', 17:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:19 INFO - 'SHELL': '/bin/bash', 17:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:38:19 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:19 INFO - 'USER': 'cltbld', 17:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:19 INFO - 'XPC_FLAGS': '0x0', 17:38:19 INFO - 'XPC_SERVICE_NAME': '0', 17:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:19 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 17:38:19 INFO - Cleaning up... 17:38:19 INFO - Return code: 0 17:38:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:38:19 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')]} 17:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 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')]} 17:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:19 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 0x10dd17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8aa4d4730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, '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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:38:19 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 17:38:19 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 17:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:19 INFO - 'HOME': '/Users/cltbld', 17:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:19 INFO - 'LOGNAME': 'cltbld', 17:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:19 INFO - 'MOZ_NO_REMOTE': '1', 17:38:19 INFO - 'NO_EM_RESTART': '1', 17:38:19 INFO - 'PAGER': '/bin/cat', 17:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:19 INFO - 'PWD': '/builds/slave/test', 17:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:19 INFO - 'SHELL': '/bin/bash', 17:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:38:19 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:19 INFO - 'USER': 'cltbld', 17:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:19 INFO - 'XPC_FLAGS': '0x0', 17:38:19 INFO - 'XPC_SERVICE_NAME': '0', 17:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:19 INFO - Downloading/unpacking psutil>=3.1.1 17:38:19 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 17:38:19 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 17:38:19 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 17:38:19 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 17:38:19 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 17:38:19 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 17:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:38:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:23 INFO - Installing collected packages: psutil 17:38:23 INFO - Running setup.py install for psutil 17:38:23 INFO - building 'psutil._psutil_osx' extension 17:38:23 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 17:38:23 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 17:38:23 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 17:38:23 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 17:38:23 INFO - building 'psutil._psutil_posix' extension 17:38:23 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 17:38:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:38:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:38:23 INFO - ^ 17:38:23 INFO - 1 warning generated. 17:38:23 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 17:38:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:23 INFO - Successfully installed psutil 17:38:23 INFO - Cleaning up... 17:38:23 INFO - Return code: 0 17:38:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:38:23 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')]} 17:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:23 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')]} 17:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:23 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 0x10dd17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8aa4d4730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, '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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:38:23 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 17:38:23 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 17:38:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:38:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:23 INFO - 'HOME': '/Users/cltbld', 17:38:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:23 INFO - 'LOGNAME': 'cltbld', 17:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:23 INFO - 'MOZ_NO_REMOTE': '1', 17:38:23 INFO - 'NO_EM_RESTART': '1', 17:38:23 INFO - 'PAGER': '/bin/cat', 17:38:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:23 INFO - 'PWD': '/builds/slave/test', 17:38:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:23 INFO - 'SHELL': '/bin/bash', 17:38:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:38:23 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:38:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:23 INFO - 'USER': 'cltbld', 17:38:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:23 INFO - 'XPC_FLAGS': '0x0', 17:38:23 INFO - 'XPC_SERVICE_NAME': '0', 17:38:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:38:24 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 17:38:24 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 17:38:24 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 17:38:24 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 17:38:24 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 17:38:24 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 17:38:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:38:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:38:26 INFO - Installing collected packages: mozsystemmonitor 17:38:26 INFO - Running setup.py install for mozsystemmonitor 17:38:26 INFO - Successfully installed mozsystemmonitor 17:38:26 INFO - Cleaning up... 17:38:27 INFO - Return code: 0 17:38:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:38:27 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')]} 17:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:27 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')]} 17:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:27 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 0x10dd17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8aa4d4730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, '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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:38:27 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 17:38:27 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 17:38:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:38:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:27 INFO - 'HOME': '/Users/cltbld', 17:38:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:27 INFO - 'LOGNAME': 'cltbld', 17:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:27 INFO - 'MOZ_NO_REMOTE': '1', 17:38:27 INFO - 'NO_EM_RESTART': '1', 17:38:27 INFO - 'PAGER': '/bin/cat', 17:38:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:27 INFO - 'PWD': '/builds/slave/test', 17:38:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:27 INFO - 'SHELL': '/bin/bash', 17:38:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:38:27 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:38:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:27 INFO - 'USER': 'cltbld', 17:38:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:27 INFO - 'XPC_FLAGS': '0x0', 17:38:27 INFO - 'XPC_SERVICE_NAME': '0', 17:38:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:27 INFO - Downloading/unpacking jsonschema==2.5.1 17:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:38:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:30 INFO - Downloading functools32-3.2.3-2.tar.gz 17:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:38:30 INFO - warning: no files found matching '*.txt' 17:38:30 INFO - no previously-included directories found matching 'build' 17:38:30 INFO - no previously-included directories found matching 'dist' 17:38:30 INFO - no previously-included directories found matching '.git*' 17:38:30 INFO - Installing collected packages: jsonschema, functools32 17:38:30 INFO - Running setup.py install for functools32 17:38:30 INFO - warning: no files found matching '*.txt' 17:38:30 INFO - no previously-included directories found matching 'build' 17:38:30 INFO - no previously-included directories found matching 'dist' 17:38:30 INFO - no previously-included directories found matching '.git*' 17:38:30 INFO - Successfully installed jsonschema functools32 17:38:30 INFO - Cleaning up... 17:38:30 INFO - Return code: 0 17:38:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:38:30 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')]} 17:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:30 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')]} 17:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:30 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 0x10dd17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8aa4d4730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, '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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:38:30 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 17:38:30 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 17:38:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:38:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:30 INFO - 'HOME': '/Users/cltbld', 17:38:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:30 INFO - 'LOGNAME': 'cltbld', 17:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:30 INFO - 'MOZ_NO_REMOTE': '1', 17:38:30 INFO - 'NO_EM_RESTART': '1', 17:38:30 INFO - 'PAGER': '/bin/cat', 17:38:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:30 INFO - 'PWD': '/builds/slave/test', 17:38:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:30 INFO - 'SHELL': '/bin/bash', 17:38:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:38:30 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:38:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:30 INFO - 'USER': 'cltbld', 17:38:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:30 INFO - 'XPC_FLAGS': '0x0', 17:38:30 INFO - 'XPC_SERVICE_NAME': '0', 17:38:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:38:30 INFO - Cleaning up... 17:38:30 INFO - Return code: 0 17:38:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:38:30 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')]} 17:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:30 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')]} 17:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:30 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 0x10dd17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8aa4d4730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, '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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:38:30 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 17:38:30 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 17:38:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:38:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:30 INFO - 'HOME': '/Users/cltbld', 17:38:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:30 INFO - 'LOGNAME': 'cltbld', 17:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:30 INFO - 'MOZ_NO_REMOTE': '1', 17:38:30 INFO - 'NO_EM_RESTART': '1', 17:38:30 INFO - 'PAGER': '/bin/cat', 17:38:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:30 INFO - 'PWD': '/builds/slave/test', 17:38:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:30 INFO - 'SHELL': '/bin/bash', 17:38:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:38:30 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:38:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:30 INFO - 'USER': 'cltbld', 17:38:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:30 INFO - 'XPC_FLAGS': '0x0', 17:38:30 INFO - 'XPC_SERVICE_NAME': '0', 17:38:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:30 INFO - Downloading/unpacking blobuploader==1.2.4 17:38:30 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 17:38:30 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 17:38:30 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 17:38:30 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 17:38:30 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 17:38:30 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 17:38:33 INFO - Downloading blobuploader-1.2.4.tar.gz 17:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:38:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:38:33 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 17:38:33 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 17:38:33 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 17:38:33 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 17:38:33 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 17:38:33 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 17:38:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:38:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:38:34 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 17:38:34 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 17:38:34 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 17:38:34 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 17:38:34 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 17:38:34 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 17:38:34 INFO - Downloading docopt-0.6.1.tar.gz 17:38:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:38:34 INFO - Installing collected packages: blobuploader, requests, docopt 17:38:34 INFO - Running setup.py install for blobuploader 17:38:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:38:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:38:34 INFO - Running setup.py install for requests 17:38:35 INFO - Running setup.py install for docopt 17:38:35 INFO - Successfully installed blobuploader requests docopt 17:38:35 INFO - Cleaning up... 17:38:35 INFO - Return code: 0 17:38:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:35 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')]} 17:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:35 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')]} 17:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:35 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 0x10dd17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8aa4d4730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, '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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:38:35 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 17:38:35 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 17:38:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:38:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:35 INFO - 'HOME': '/Users/cltbld', 17:38:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:35 INFO - 'LOGNAME': 'cltbld', 17:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:35 INFO - 'MOZ_NO_REMOTE': '1', 17:38:35 INFO - 'NO_EM_RESTART': '1', 17:38:35 INFO - 'PAGER': '/bin/cat', 17:38:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:35 INFO - 'PWD': '/builds/slave/test', 17:38:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:35 INFO - 'SHELL': '/bin/bash', 17:38:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:38:35 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:38:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:35 INFO - 'USER': 'cltbld', 17:38:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:35 INFO - 'XPC_FLAGS': '0x0', 17:38:35 INFO - 'XPC_SERVICE_NAME': '0', 17:38:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-mhqr8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-C9XBfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-VxI_XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-KfB65R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-EkR7la-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-j4lDmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-rZ_Ax8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-wFvr4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:36 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-m9owq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-UhXnO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-FaH2ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-WogRAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-9o6iIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-uuZWrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-LUowR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-p6EFWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:37 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-x2doWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:38:37 INFO - Running setup.py install for manifestparser 17:38:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:38:38 INFO - Running setup.py install for mozcrash 17:38:38 INFO - Running setup.py install for mozdebug 17:38:38 INFO - Running setup.py install for mozdevice 17:38:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:38:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:38:38 INFO - Running setup.py install for mozfile 17:38:38 INFO - Running setup.py install for mozhttpd 17:38:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:38:38 INFO - Running setup.py install for mozinfo 17:38:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:38:38 INFO - Running setup.py install for mozInstall 17:38:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Running setup.py install for mozleak 17:38:39 INFO - Running setup.py install for mozlog 17:38:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Running setup.py install for moznetwork 17:38:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Running setup.py install for mozprocess 17:38:39 INFO - Running setup.py install for mozprofile 17:38:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Running setup.py install for mozrunner 17:38:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:38:39 INFO - Running setup.py install for mozscreenshot 17:38:40 INFO - Running setup.py install for moztest 17:38:40 INFO - Running setup.py install for mozversion 17:38:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:38:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:38:40 INFO - Cleaning up... 17:38:40 INFO - Return code: 0 17:38:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38: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')]} 17:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38: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')]} 17:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:40 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 0x10dd17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8aa4d4730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, '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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:38:40 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 17:38:40 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 17:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:40 INFO - 'HOME': '/Users/cltbld', 17:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:40 INFO - 'LOGNAME': 'cltbld', 17:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:40 INFO - 'MOZ_NO_REMOTE': '1', 17:38:40 INFO - 'NO_EM_RESTART': '1', 17:38:40 INFO - 'PAGER': '/bin/cat', 17:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:40 INFO - 'PWD': '/builds/slave/test', 17:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:40 INFO - 'SHELL': '/bin/bash', 17:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:38:40 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:40 INFO - 'USER': 'cltbld', 17:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:40 INFO - 'XPC_FLAGS': '0x0', 17:38:40 INFO - 'XPC_SERVICE_NAME': '0', 17:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:40 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-dR5FzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:40 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)) 17:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:40 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-IZO7Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:40 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-XJVr6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:41 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)) 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:41 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-hjagYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:41 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)) 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:41 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-FWSfpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:41 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)) 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:41 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-s28n74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:41 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)) 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:41 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-L4igu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:41 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)) 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:41 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-vasK9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:41 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)) 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:41 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Yyk08j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:41 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)) 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:41 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-1jjh3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:41 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)) 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:41 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-d1QaG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:41 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)) 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:41 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-9YWtCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:41 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)) 17:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:42 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-WilWmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:42 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-B2XD2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:42 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-5lsIvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:42 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-IFp7PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:42 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)) 17:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:42 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-OqM3hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:42 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)) 17:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:38:42 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)) 17:38:42 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)) 17:38:42 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)) 17:38:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:45 INFO - Downloading blessings-1.6.tar.gz 17:38:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:38:45 INFO - Installing collected packages: blessings 17:38:45 INFO - Running setup.py install for blessings 17:38:45 INFO - Successfully installed blessings 17:38:45 INFO - Cleaning up... 17:38:45 INFO - Return code: 0 17:38:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:45 INFO - Reading from file tmpfile_stdout 17:38:45 INFO - Current package versions: 17:38:45 INFO - blessings == 1.6 17:38:45 INFO - blobuploader == 1.2.4 17:38:45 INFO - docopt == 0.6.1 17:38:45 INFO - functools32 == 3.2.3-2 17:38:45 INFO - jsonschema == 2.5.1 17:38:45 INFO - manifestparser == 1.1 17:38:45 INFO - mozInstall == 1.12 17:38:45 INFO - mozcrash == 0.17 17:38:45 INFO - mozdebug == 0.1 17:38:45 INFO - mozdevice == 0.48 17:38:45 INFO - mozfile == 1.2 17:38:45 INFO - mozhttpd == 0.7 17:38:45 INFO - mozinfo == 0.9 17:38:45 INFO - mozleak == 0.1 17:38:45 INFO - mozlog == 3.4 17:38:45 INFO - moznetwork == 0.27 17:38:45 INFO - mozprocess == 0.23 17:38:45 INFO - mozprofile == 0.28 17:38:45 INFO - mozrunner == 6.12 17:38:45 INFO - mozscreenshot == 0.1 17:38:45 INFO - mozsystemmonitor == 0.3 17:38:45 INFO - moztest == 0.7 17:38:45 INFO - mozversion == 1.4 17:38:45 INFO - psutil == 3.1.1 17:38:45 INFO - requests == 1.2.3 17:38:45 INFO - wsgiref == 0.1.2 17:38:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:45 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 0x10dd17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8aa4d4730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, '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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:38:45 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 17:38:45 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 17:38:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:38:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:45 INFO - 'HOME': '/Users/cltbld', 17:38:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:45 INFO - 'LOGNAME': 'cltbld', 17:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:45 INFO - 'MOZ_NO_REMOTE': '1', 17:38:45 INFO - 'NO_EM_RESTART': '1', 17:38:45 INFO - 'PAGER': '/bin/cat', 17:38:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:45 INFO - 'PWD': '/builds/slave/test', 17:38:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:45 INFO - 'SHELL': '/bin/bash', 17:38:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:38:45 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:38:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:45 INFO - 'USER': 'cltbld', 17:38:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:45 INFO - 'XPC_FLAGS': '0x0', 17:38:45 INFO - 'XPC_SERVICE_NAME': '0', 17:38:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:46 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)) 17:38:46 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)) 17:38:46 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)) 17:38:46 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)) 17:38:46 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)) 17:38:46 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)) 17:38:46 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)) 17:38:46 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)) 17:38:46 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)) 17:38:46 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)) 17:38:46 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)) 17:38:46 INFO - Cleaning up... 17:38:46 INFO - Return code: 0 17:38:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:38:46 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')]} 17:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:46 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')]} 17:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:46 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 0x10dd17490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8aa4d4730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, '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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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 17:38:46 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 17:38:46 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 17:38:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:38:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:46 INFO - 'HOME': '/Users/cltbld', 17:38:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:46 INFO - 'LOGNAME': 'cltbld', 17:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:46 INFO - 'MOZ_NO_REMOTE': '1', 17:38:46 INFO - 'NO_EM_RESTART': '1', 17:38:46 INFO - 'PAGER': '/bin/cat', 17:38:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:46 INFO - 'PWD': '/builds/slave/test', 17:38:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:46 INFO - 'SHELL': '/bin/bash', 17:38:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:38:46 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:38:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:46 INFO - 'USER': 'cltbld', 17:38:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:46 INFO - 'XPC_FLAGS': '0x0', 17:38:46 INFO - 'XPC_SERVICE_NAME': '0', 17:38:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:38:46 INFO - Cleaning up... 17:38:46 INFO - Return code: 0 17:38:46 INFO - Running post-action listener: _resource_record_post_action 17:38:46 INFO - Running post-action listener: _start_resource_monitoring 17:38:46 INFO - Starting resource monitoring. 17:38:46 INFO - [mozharness: 2016-10-18 00:38:46.346797Z] Finished create-virtualenv step (success) 17:38:46 INFO - [mozharness: 2016-10-18 00:38:46.347617Z] Running install step. 17:38:46 INFO - Running pre-action listener: _resource_record_pre_action 17:38:46 INFO - Running main action method: install 17:38:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:46 INFO - Reading from file tmpfile_stdout 17:38:46 INFO - Detecting whether we're running mozinstall >=1.0... 17:38:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:38:46 INFO - Reading from file tmpfile_stdout 17:38:46 INFO - Output received: 17:38:46 INFO - Usage: mozinstall [options] installer 17:38:46 INFO - Options: 17:38:46 INFO - -h, --help show this help message and exit 17:38:46 INFO - -d DEST, --destination=DEST 17:38:46 INFO - Directory to install application into. [default: 17:38:46 INFO - "/builds/slave/test"] 17:38:46 INFO - --app=APP Application being installed. [default: firefox] 17:38:46 INFO - mkdir: /builds/slave/test/build/application 17:38:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:39:21 INFO - Reading from file tmpfile_stdout 17:39:21 INFO - Output received: 17:39:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:39:21 INFO - Running post-action listener: _resource_record_post_action 17:39:21 INFO - [mozharness: 2016-10-18 00:39:21.741789Z] Finished install step (success) 17:39:21 INFO - [mozharness: 2016-10-18 00:39:21.741941Z] Running run-tests step. 17:39:21 INFO - Running pre-action listener: _resource_record_pre_action 17:39:21 INFO - Running main action method: run_tests 17:39:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:39:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:39:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:39:21 INFO - 2016-10-17 17:39:21.756 screenresolution[1946:16928] starting screenresolution argv=screenresolution get 17:39:21 INFO - 2016-10-17 17:39:21.759 screenresolution[1946:16928] Display 0: 1600x1200x32@60 17:39:21 INFO - 2016-10-17 17:39:21.765 screenresolution[1947:16930] starting screenresolution argv=screenresolution list 17:39:21 INFO - Available Modes on Display 0 17:39:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:39:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:39:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:39:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:39:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:39:21 INFO - Intel Iris: 17:39:21 INFO - Chipset Model: Intel Iris 17:39:21 INFO - Type: GPU 17:39:21 INFO - Bus: Built-In 17:39:21 INFO - VRAM (Dynamic, Max): 1536 MB 17:39:21 INFO - Vendor: Intel (0x8086) 17:39:21 INFO - Device ID: 0x0a2e 17:39:21 INFO - Revision ID: 0x0009 17:39:21 INFO - Displays: 17:39:21 INFO - Display: 17:39:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:39:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:39:21 INFO - Display Serial Number: 1600x1200 60 17:39:21 INFO - Main Display: Yes 17:39:21 INFO - Mirror: Off 17:39:21 INFO - Online: Yes 17:39:21 INFO - Rotation: Supported 17:39:21 INFO - Return code: 0 17:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:39:22 INFO - Python 2.7.3 17:39:22 INFO - Return code: 0 17:39:22 INFO - grabbing minidump binary from tooltool 17:39:22 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')]} 17:39:22 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 0x10db2bd30>, '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 0x10d951db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db23b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:39:22 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 17:39:22 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 17:39:22 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 17:39:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:39:22 INFO - Return code: 0 17:39:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:39:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:39:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:39:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:39:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:39:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 17:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --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 17:39:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OMB5Dm9c8H/Render', 17:39:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:22 INFO - 'HOME': '/Users/cltbld', 17:39:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:22 INFO - 'LOGNAME': 'cltbld', 17:39:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:22 INFO - 'MOZ_NO_REMOTE': '1', 17:39:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:22 INFO - 'NO_EM_RESTART': '1', 17:39:22 INFO - 'PAGER': '/bin/cat', 17:39:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:22 INFO - 'PWD': '/builds/slave/test', 17:39:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:22 INFO - 'SHELL': '/bin/bash', 17:39:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HcwUN7gWnt/Listeners', 17:39:22 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 17:39:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:22 INFO - 'USER': 'cltbld', 17:39:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:22 INFO - 'XPC_FLAGS': '0x0', 17:39:22 INFO - 'XPC_SERVICE_NAME': '0', 17:39:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--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 17:39:22 INFO - mozversion application_buildid: 20161017151219 17:39:22 INFO - mozversion application_changeset: 07e27ed94ad03941605d4f508695215f85c2b1a4 17:39:22 INFO - mozversion application_display_name: Nightly 17:39:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:39:22 INFO - mozversion application_name: Firefox 17:39:22 INFO - mozversion application_remotingname: firefox 17:39:22 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 17:39:22 INFO - mozversion application_vendor: Mozilla 17:39:22 INFO - mozversion application_version: 52.0a1 17:39:22 INFO - mozversion platform_buildid: 20161017151219 17:39:22 INFO - mozversion platform_changeset: 07e27ed94ad03941605d4f508695215f85c2b1a4 17:39:22 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 17:39:22 INFO - mozversion platform_version: 52.0a1 17:39:22 INFO - using testdate: 1476751162 17:39:22 INFO - actual date: 1476751162 17:39:22 INFO - starting webserver on 'localhost:52053' 17:39:22 INFO - SUITE-START | Running 2 tests 17:39:22 INFO - TEST-START | dromaeo_css 17:39:22 INFO - operating with platform_type : mac_ 17:39:22 INFO - Initialising browser for dromaeo_css test... 17:39:22 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpqsA99h/profile http://localhost:52053/getInfo.html) 17:39:24 INFO - PROCESS | 1957 | __metrics Screen width/height:1600/1200 17:39:24 INFO - PROCESS | 1957 | colorDepth:24 17:39:24 INFO - PROCESS | 1957 | Browser inner width/height: 1024/689 17:39:24 INFO - PROCESS | 1957 | __metrics 17:39:24 INFO - PROCESS | 1957 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:39:24 INFO - PROCESS | 1957 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:39:25 INFO - TEST-INFO | 1957: exit 0 17:39:25 INFO - Browser initialized. 17:39:25 INFO - Running cycle 1/1 for dromaeo_css test... 17:39:25 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpqsA99h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:37 INFO - PROCESS | 1959 | RSS: Main: 245964800 17:39:37 INFO - PROCESS | 1959 | 17:40:29 INFO - PROCESS | 1959 | 1476751229193 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] 17:42:43 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52053/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52053/tests/dromaeo/cssquery-ext.html) 17:42:45 INFO - PROCESS | 1959 | RSS: Main: 351313920 17:42:45 INFO - PROCESS | 1959 | 17:45:47 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52053/tests/dromaeo/cssquery-ext.html (next: http://localhost:52053/tests/dromaeo/cssquery-jquery.html) 17:45:48 INFO - PROCESS | 1959 | RSS: Main: 372580352 17:45:48 INFO - PROCESS | 1959 | 17:48:50 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52053/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52053/tests/dromaeo/cssquery-mootools.html) 17:48:51 INFO - PROCESS | 1959 | RSS: Main: 331554816 17:48:51 INFO - PROCESS | 1959 | 17:51:54 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52053/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52053/tests/dromaeo/cssquery-prototype.html) 17:51:54 INFO - PROCESS | 1959 | RSS: Main: 337960960 17:51:54 INFO - PROCESS | 1959 | 17:54:58 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52053/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52053/tests/dromaeo/cssquery-yui.html) 17:54:58 INFO - PROCESS | 1959 | RSS: Main: 330661888 17:54:58 INFO - PROCESS | 1959 | 17:58:02 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:52053/tests/dromaeo/cssquery-yui.html (next: http://localhost:52053/tests/dromaeo/cssquery-dojo.html) 17:58:02 INFO - PROCESS | 1959 | RSS: Main: 424787968 17:58:02 INFO - PROCESS | 1959 | 17:58:02 INFO - PROCESS | 1959 | __start_tp_report 17:58:02 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 17:58:02 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 17:58:02 INFO - PROCESS | 1959 | |i|pagename|runs| 17:58:02 INFO - PROCESS | 1959 | |0;dojo.html;3327.8169700666463;3331.2338162222695;3338.5326054352395;3372.2749608834097;3392.5759280089987;5410.83767486976;5568;5696.572757043217;5740.684262365568;5768.653880767151;4167.354060120679;5655.236543066685;5780.901628690546;5796.362400135981;5808.303003639569;5122;5138.640295179339;5154.252633368159;5189.299444574972;5219.42586315505;5179.19722443022;5268.446813084628;5271.551918086967;5280.9207861882105;5292.894142117156;5148.176291793333;5220.686758794446;5231.372235331784;5234;5340.145576707728;4312.3531470279395;5218.869528261824;5228.215767634847;5235.73821308933;5237.554807841338;5114.46542133335;5184.248283998799;5196.76614552346;5197.974010129963;5220.321358223445;5720.2849643794525;5724.16999535065;5729.799457019026;5729.885402291972;5736.082226843685;4572.588467037949;6137.660235595016;6150.862090513225;6159.983602705548;6170.382961703794;6102.671035646916;6104.541389247765;6111.969440152815;6121.510279177655;6142.539309551801;5579.191017302509;5633.126865335879;5650.406707295716;5650.463205995424;5657.519110875622;5632.774689012475;6211.627302361872;6260.780872669435;6270.122182894398;6272.749090036439;5106.872328191825;6153.938460615336;6159.137720719103;6160.10678451631;6165.5375846810775;6115.909724157157;6129.816105516842;6141.148492690724;6144.4945988232275;6245.96877015612;6165.876682466325;6177.722002509898;6202.627842329474;6211.534134939898;6215.502759779207;6210.285817130997;6226.377362263737;6226.533010024266;6241.937580624226;6252.906206406908;4804.183288840835;4905.9264111038365;4907.312976183337;4924.384451943507;4959.330490383824;4323.7621930793475;4363.083752411965;4393.670474714345;4396.912061758747;4454.064646424287;5760.308762948473;5774.220480235199;5781.739821708034;5782;5790.913136302959;6248.9062664060075;6294.559380843297;6295.338989406138;6301.306856245901;6303.369663033752;5594.692291923983;5658.7170641467765;5666.320041594952;5720.256366672306;5822.621529600562;4542.273236282245;5310.8141215057285;5374.48942350476;5410.486003829708;5449.073657478239;6270.122182894307;6272.2159730033745;6278.780242691484;6281.183446151971;6282.057691346335;6100.611450805989;6151.108089327112;6154.83058218937;6241.812745617639;6282.089097080989;6206.379362063757;6245.875082498415;6266.843328916813;6287.591306565058;6317.084022816574;5994.250718660168;6017.2779266488305;6023.728932198149;6025;6068.271807383142;6037.003894357382;6122.326544080237;6132.9386706134155;6145.477634401126;6153.815385538441;5951.91072133927;6064.241969753781;6066.938285799879;6110.908336374869;6118.497354392036;6092.421219984094;6100;6113.663748493876;6116.541259405473;6144.354842741448;5676.829695109153;5912.674802885883;5917.112433135064;5932.377100404568;5933.495652869382;5051.419086804917;5899.911501327398;5968.045112781934;6118;6138.917619782973;5943;5943.227380440515;5960.821175364746;5963.4632883039;6019.067044608093 17:58:02 INFO - PROCESS | 1959 | |1;ext.html;471.2201306837185;475.23012719394586;486.68122379841196;523.3379774585151;565.9688717120557;30375;41572;41652;41736.165276694446;43602.473913413036;42604.147917041715;42928.57071429285;43127.78436107823;43172.3524147138;43186.7840660797;9592.040795920422;9767.560459779326;9788.070133337322;9790.265730070238;9791.265655075862;9622.855657165148;9735.561899714494;9737.561809718543;9740.220782337396;9744.902550974506;9681.564329605184;9724.902750972506;9730.708078757649;9741.025897410273;9746.610135594603;9697;9726.9513652432;9728.513574321256;9736.367136136128;9740.805183896282;9605.615775368977;9679.225661947097;9687.903120968842;9690.75773105671;9691.224702023892;39081.804590977146;39586.20827583461;39638.60361396378;39689.404658930136;39818.80090599557;3318.4026875162463;3541.4510750833406;3767.5290588676417;3934.390169523728;4069.674426045909;29773.70226297731;31076.68923310783;31227;31233.8438307807;31267.218319541968;3198.616166060064;3319.2697606526526;3360.5631267935255;3367.8316084195694;3397.69420752131;454254.9999999967;456367;457171;457813;461889;59133.70433147807;59998.80002400015;60145.398546014854;60183.69908150431;62904;63143.36856631467;63238.051429228595;63321.683391582745;63324.36675633277;63346;15835.366585336687;16051.678966420606;16087.195640217942;16111.597210069842;16180.67638647244;12419.689507762198;12452.875471245352;12463.065270104778;12482;12489.437975290952;14212.786808197885;16686.83313166853;17337.739933901;17341.56646083858;17350.3059877606;6900;6930.93069069313;6938.653067346612;6943;7009.579425234502;793.412874472886;811.8213992921548;993.3344659078434;1032.6127702111708;1090.3076546393097;26416.603750943752;26941.595876061874;33091.43686502169;34168.65831341704;34444.311113777585;904.5929331800716;971.6437638726202;995.2436148527026;1092.3282181458346;1134.2230572058002;14722.55832325032;15201.011934224462;15405.537833865003;15578.844211557966;15802.841971580367;658218.7226596675;682546;682808;684767;685699;58261.126083108786;58940.7052964741;59057;59066.40933590609;59089.70455147697;1251.3117785218094;1289.8000809874297;1347.070521340272;1388.8819450346834;1412.3644360038024;29973.700262997092;29985.250368740955;31057.844710776302;31096.533551997192;31218.843905781236;50689.74655126701;51251.743741282546;51359.74320128375;51367.48632513627;51531.22703159531;567030;575270;576289;577367;577543;42413;42890;43656;43713.754349478266;44464.55535444604;46774.298385523565;47037.529624704686;47260;48138.75930620325;48638.02723945572;39028.6097139025;39187.41218881662;39200.01999950024;39568.60431395649;40234.39648405335;38744.41883371808;39071;39811.80094099511;40205.597944021356;40550;37248.32382542738;37863.43204851874;38667.613323866404;38701.80649096736;38743.418848717854;29971.250718732204;34215;34896;35235;35305.29389412146;21809;24886.37784055413;25041.87479062593;25649.230523084338;25807.483850323264 17:58:02 INFO - PROCESS | 1959 | |2;jquery.html;353.2793102071774;365.9560852697675;376.13113707336055;381.6660422130636;400.9478767760191;14560.70878582429;14675.486357977474;15508.379664813394;19426.611467770635;20305.59388812223;19415.12631931563;19852.60294794103;20488.8975555122;20526.076326565304;20771.68842467364;5690.60165788396;5938.61399009063;6011.969940150315;6015.75936962521;6018.969905150469;5677.347105082907;5904;5968.731407086691;5970.253718285215;5975.940240597603;3670.137517683342;4353.5211126776185;5934.287885453751;6129.785457508988;6431.774887878925;5696.914546281809;6507.707153178095;6529.053287273367;6538.150040494753;6570.540062195648;5759.1937128802;5868.295804503444;5870.236869207019;5872.677002764846;5876.823695289148;13037.217766934014;14426.639334016629;24105.758942410528;24660.383490412703;24981.750182498123;1865.9440216793519;2012.3459875540361;2165.53441010182;2208.933731988043;2211.590855691702;9530.237580993573;10053.648122315757;10171.949140254252;10233.846492302622;10379.89620103797;1677.178182690485;1751.106935462923;1800.9819901800945;1824.6533158699938;1835.1191428114446;111557;115648.42175789067;116149;117728.41135794266;118113.59807220205;9489.667861624948;11268.943655281671;11369.31784092957;11502.177428154711;11634.149633339886;14493.92753036249;14501.419943202365;14508.492202772852;14514.056586321854;14527.273636318141;8202.958985205156;8374.832503349899;8378.748637540884;8499.107593702696;8505.106963768716;8238.340932725368;8253.09215986241;8276.544790036485;8434.439628668715;8460.196281353385;3914.3541315683165;4480.484744254387;4483.260262056724;4560.566746159109;4588.908221835612;1850.3708739028796;1899.2972600137762;1910.9713354299697;1915.817997290283;1922.6154769046248;715.7924201981367;823.872299793533;839.886615306938;900.9773906616037;952.8946422150273;19988;20487.4878128048;20577.176912923616;20584.176632934814;20607.969601519864;879.0023323527714;898.3262553085186;904.7150147703452;913.3469569258012;1006.2151521812998;8933;10197.235207359477;10808.351498910091;10826.891731082746;10869.619563315404;615573;617341;619702.7193232425;630426;642538;92064;122565;126359;127206;128425;925.6528801699362;977.726236653738;985.0346660272972;987.6641941739842;1000.9599616015423;13560.660983475493;18608.906955465136;19123.617527649647;19259.90370048197;19354.225830966603;48065.5193448075;54208.66847405461;54530.72734636301;55178.44821551894;55702.88594228012;78199.60900195462;82280.58859705663;82636.17363826526;82636.3472730554;83589.58205208935;6618.702158402787;8049.034115906129;8174.141715119827;8206.548639824628;8218.712345067894;9995.850062248926;10954.233203675985;12216.877831221575;12478.313692746622;12826.422810973716;10760.89239107599;10777.568897244022;11113.722156946142;11132.38771867555;11224.326540407601;10820.4048777318;11018.724531886766;11212.04697600713;11284.605038823602;11284.887151128383;10920.563177472812;11034.889651103385;11152.219344645797;11177.441127943408;11414.94292528532;7062.223155452999;7345.378147076885;7472.29013243741;7901.920980790348;8305.013593475045;8283.17168283167;9097.454152750855;10471.68584942453;11630.592929247436;11682.88317116818 17:58:02 INFO - PROCESS | 1959 | |3;mootools.html;1347.2186132043416;1495.1253516692739;1523.1318148655264;1703.727403615421;1859.804720504347;7551.773446796598;7993.080795708495;7996.800079998003;7997.200279972;8004.639791209395;7825.982622259113;8371.246587807096;8594.527300998443;8625.309975201984;8654.524001179949;2310.9884450577724;2344.9062037518565;2346.2022912209845;2346.77705617966;2347.9765202348012;2293.4495721026915;2323.337848713117;2335.824813139013;2337.3221765688013;2339.1695947938492;2291.9656205156853;2314.351981445198;2323.53529294141;2326.3718795925092;2328.487732698812;2220.9888950555305;2281.1103669568884;2308.4113551044543;2310.861348319106;2311.9884400578057;1985.4639247403265;1999.2502811445709;2286.7141607299086;2288.439332363565;2294.219965211836;8515.403921725481;8723.825523489495;8734.51960142192;8764.912350876473;8766.561671916379;4960.727160006199;5116.513931176532;5276.28520730764;5286.709230992294;5295.232191332274;3213.550102985584;3566.7555608825674;3661.21283923955;3673.448982652597;3674.4488326750934;1064.1912146768511;1075.8924107589257;1082.2316155529504;1094.5402930769096;1098.9120870330435;11420.31478111316;11466.942665286704;11475.827862582068;11497;11501.827472587918;4378.64970802335;4562.657800664963;4626.629869610423;4798.66409351349;4825.927611085836;9071.501067441353;9123.361364704408;9131.041240669634;9151.90848091524;9163.129502697233;5183.637145399861;5232.136697444879;5233.136532472099;5241.292425522582;5246.108161612535;4359.825606975749;4507.81968721254;4721.693089949143;4866.78099485524;4915.4347250065985;3619.2218672985437;3673.504076949631;3729.9067523312133;3762.529683789526;3769.9444155635915;1123.1856903744883;1126.9887301127048;1129.6554550861902;1141.2125633312987;1147.3402793393666;742.1835980421494;796.6295672512309;893.4862454088925;901.6123067081087;934.5187228577288;5360.758765855468;5547.951364258505;5980.699060873741;6015.789447369321;6026.397360263939;930.9953450232841;934.313279739391;944.8960614332418;960.8366577681811;999.9600015999279;3921.1569512554365;3946.8223929923224;3957.465742124834;4056.6815784870037;4091.652209562161;10389.272750907516;10711.946440267904;10725.30285531438;10738.892611073945;10769.730756731144;10619.256652034283;10710.196735244888;10712;10720.303180293256;10750.623728169476;7930.325922296554;8069.394795390369;8078.757637270891;8103.270705636403;8255.215754503313;5451.945480545144;5787.508061814793;5801.361850196559;5895.498882595028;5961.880762384815;9586.376885502421;9978.650747224103;10002.399856008662;10013;10064.496775161359;9960.452175130438;9989.850152247867;10100.797984040424;10162.695119146438;10294.794104118026;6401.743930242738;6904.275051119761;7133.5719856808755;7187.9640601796655;7578.507397019176;8078.272955434039;8164.7550573482895;8254.876176857231;8269.338452923632;8283.917160828314;7242.710291588488;7319.194888562148;7348.265173482609;7399.59302238382;7505.662245199088;7087.539309944837;7116.252793456612;7128.572285662877;7167.1757747859665;7264.055672762507;6762.357576030269;6789.388954994074;6859.794206173823;6872.037914691847;6877.209120951155;4724.05518896229;4734.479207287127;4750.762461876961;4807.95192048089;4911.091448082117;4830.372051633265;4884.731339776346;4909.140900342497;4982.626303027215;5043.9464724047475 17:58:02 INFO - PROCESS | 1959 | |4;prototype.html;298.97907146499745;300.19547612398765;307.24264687545195;312.8545226469691;315.043841939713;4182.351735480997;4376.431063961684;5230.503102205284;5233.319668443107;5276.736163191844;4141.57115795051;4895.388076490439;4982.9252561211615;4995.52542508462;5078.19723997981;3998.9800050999706;4032.254033003889;4034.2249410259537;4036.253293140771;4049.987503124219;3989.4414781930554;4013.1973605278913;4028.1943611277716;4036.374361973899;4064.0652649890544;3341.8779075287125;3343.7325013998943;3893.6301051400073;3964.2666106770193;4013.8193781279765;3653.5615726112906;3998.540167880673;4006.959930400688;4010.498687664042;4011.29802284599;2928;2959.852007399643;3081.4299354619243;3482.3905816482015;3519.9296014079832;4502.851772797948;4651.6045186443935;4871.7846221494;5115.974420127875;5188.844334669966;4363.563643635643;4527.890666786626;4552.203364411214;4598.310253461974;4602.79287432063;4867.586255168315;5487.42382049883;5526.281583394133;5584.385717571064;5609.411011843779;3817.8091095445116;3870.1872606752618;3894.4547763313158;3902.687784977195;3909.9413508797393;4759;5325.4940780625775;5705.974379095403;5740.827775166752;5874.295084589834;3242.4974129010043;3323.7673362864366;3483.268513612119;3792.241551689673;3801.5248093988253;3852.730308878408;3867.16855875988;3881.262560113569;3888.96111038886;3890.396988466792;3894.415837624379;4514.187446259639;4526.343680166357;4536.457604414515;4553.521880202531;5303.1628078977565;5559.33288005442;5561.972190139023;5579.540684775465;5659.915101273484;1124.7244425115898;1176.952921883115;1219.9817002744967;1255.1653150654713;1287.6137158852307;823.5552801487249;843.1315744782884;855.3200205836375;870.4081224767219;885.9855465491976;5183.637145399861;5224.973875130676;5241.711705856138;5253.711045892513;5256.369235691742;4744.383230180124;5323.3079699639575;5506.64206826555;5619.157126431068;5651.971740141355;4044.6157615026527;4914.729689867092;5047.798088076509;5064.46823083571;5142.794288228429;2643.6959749628654;2794.1896849913705;2860.382749783966;2926.7365937065765;2940.4560156370712;5441.455854414527;5703.722208343742;5744.396838331999;5755.323824363718;5761.8559536011935;4577.908441831145;4985.376827896513;5565.276514053147;5694.886102277931;5743.167240750068;5316.813911513079;5719.252151587711;5773.797917072882;5830.475257226785;5831.504322132666;4320.364577607594;4896.877578060577;5603.691796951207;5606.747696353592;5658.094704847369;4921.704697718148;5445.346558413015;5598.692071936082;5643.830685079454;5668.348139963957;5158.724210126522;5273.789048438173;5390.757415916215;5656.210339072749;5896.8820623586425;3383.7462190336314;3495.563054618173;3784.9243015140096;3795.6963442923948;3845.2117315949604;4754.643401744814;5707.315122185364;5727.226824378656;5756;5776.7111644418455;5579.46995035471;5587.240019393878;5603.7758489659955;5605.187247848958;5610.943890561042;5234.743661521284;5502.58730595199;5565.276514053147;5593.664380137205;5648.977796878815;4403.899025243689;4651.650811415775;5188.299579556862;5337.092694241911;5509.338879334506;5262.210668399771;5472.753726082256;5480.972595136999;5565.660603637785;5606.551475881838;5184.922226166535;5459.863503412446;5460.563154947516;5460.689434535762;5473.480019398151 17:58:02 INFO - PROCESS | 1959 | |5;yui.html;681.9624920629365;750.9774706758795;770.4144849914063;786.3119770201076;788.2283274531369;15058.934087796288;15699.293531791069;15739.685206295868;15747.291371888265;16043.35826566936;14047.719045619082;14184.787228191586;14199.858001419983;14214.147151170911;14261.073030253026;670.9463242940577;691.0084029417801;819.7581713394533;821.6138414944982;843.7173546861809;837.8994520657529;838.6980686952692;840.1094839470151;840.9663613455485;841.0202114536557;889.3463304471209;890.4835195586577;890.7194233816327;890.7327801659509;891.2780647675404;701.4318402094294;725.8838585826243;859.3511898516642;870.712664820614;884.7434244069212;631.4254028833785;632.1276638239201;644.3170239546096;656.8489247473108;658.4238791057825;12834;14586.781198282035;14937.701245975128;15010.624734381729;15059.17174555399;13566.45734170632;13825.585232443043;13934.163950162922;13937.233452160128;14099.577012689533;12208.145429819917;12231.143819932608;12360.25838449696;12421.130520863544;12432.316222607753;3907.7069219808627;4658;4665.393498845128;4666.440027196758;4671.579557839811;113801;118197;121211;121337;121558.39220803839;10702.464876756287;11079.667609971713;11089.778204435866;11102.888971110186;11149.665510034712;21632.675509867364;22397.776022239894;22408.887955560444;22428;22444.438889027904;7793.883091753628;7831.647575858986;8027.478213916193;8132.55270960091;8180.46826956246;4346.739195648272;4356.912861742748;4372.825086996484;4384.145091707151;4419.138268037702;3479.7912125272564;3565.750397472204;3577.821108944542;3584.6415358464465;3590.2281009583066;625.3590070178104;626.8683576448906;627.5607075047485;642.0177128992649;648.1638686094979;522.2271038862505;603.5684485592823;603.8912995660824;612.1552257884091;627.6171535363425;7587.620618969029;8928.375013749104;9006.549672516348;9020.458772473672;9167;567.7396180479329;569.9316082070178;612.2102487790789;622.2408661433044;631.1952260867431;4435.157320109169;4467.396901418332;4468.687191896601;4470.240059189946;4591.95408045922;122651.16023259658;158661;158806.2059689694;161075;164407;145426;147016.26491867471;147878.52121478648;148680;149195;119653.40173299251;120006.3999679996;121477;122255.3887230576;126289;7121.433284677362;7912.453742463927;8047.839043218985;8564.272036876935;8722.869156962524;62292.68853655703;65144.67427662831;65760;66091.67816643737;67849.61926722107;65057.34942650513;79215.415691687;87534.1246587526;95454.36365090637;97031;10945.726356841144;13233.867661323264;13289.278274477248;13430.597082087554;13642.181469111885;14139.350359533846;14593.489227876973;14618.195999219719;14756.262186890826;15428.151451670266;13838.23889686077;13904.026718129633;13956.511522096678;13987.510437134652;14095.506657266946;13342.06605537603;13599.116057456235;14009.299535023412;14203.360848762037;14471.710565788835;13043.478260869459;13571.864281357455;13705.657358566115;14005.579832605039;14175.64560885986;10827.837582436112;10961;11228.55085796559;11243.49404276826;11661.475233614678;9512.714618561455;9841.45871977048;10034.69895903124;10511.369317840954;11378.37418941933 17:58:02 INFO - PROCESS | 1959 | __end_tp_report 17:58:02 INFO - PROCESS | 1959 | __start_cc_report 17:58:02 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,1778 17:58:02 INFO - PROCESS | 1959 | __end_cc_report 17:58:02 INFO - PROCESS | 1959 | __startTimestamp1476752282314__endTimestamp 17:58:02 INFO - PROCESS | 1959 | 17:58:02 INFO - PROCESS | 1959 | ------- Summary: start ------- 17:58:02 INFO - PROCESS | 1959 | Number of tests: 6 17:58:02 INFO - PROCESS | 1959 | 17:58:02 INFO - PROCESS | 1959 | [#0] dojo.html Cycles:165 Average:5675.23 Median:5917.11 stddev:657.96 (11.1%) stddev-sans-first:633.69 17:58:02 INFO - PROCESS | 1959 | Values: 3327.8 3331.2 3338.5 3372.3 3392.6 5410.8 5568.0 5696.6 5740.7 5768.7 4167.4 5655.2 5780.9 5796.4 5808.3 5122.0 5138.6 5154.3 5189.3 5219.4 5179.2 5268.4 5271.6 5280.9 5292.9 5148.2 5220.7 5231.4 5234.0 5340.1 4312.4 5218.9 5228.2 5235.7 5237.6 5114.5 5184.2 5196.8 5198.0 5220.3 5720.3 5724.2 5729.8 5729.9 5736.1 4572.6 6137.7 6150.9 6160.0 6170.4 6102.7 6104.5 6112.0 6121.5 6142.5 5579.2 5633.1 5650.4 5650.5 5657.5 5632.8 6211.6 6260.8 6270.1 6272.7 5106.9 6153.9 6159.1 6160.1 6165.5 6115.9 6129.8 6141.1 6144.5 6246.0 6165.9 6177.7 6202.6 6211.5 6215.5 6210.3 6226.4 6226.5 6241.9 6252.9 4804.2 4905.9 4907.3 4924.4 4959.3 4323.8 4363.1 4393.7 4396.9 4454.1 5760.3 5774.2 5781.7 5782.0 5790.9 6248.9 6294.6 6295.3 6301.3 6303.4 5594.7 5658.7 5666.3 5720.3 5822.6 4542.3 5310.8 5374.5 5410.5 5449.1 6270.1 6272.2 6278.8 6281.2 6282.1 6100.6 6151.1 6154.8 6241.8 6282.1 6206.4 6245.9 6266.8 6287.6 6317.1 5994.3 6017.3 6023.7 6025.0 6068.3 6037.0 6122.3 6132.9 6145.5 6153.8 5951.9 6064.2 6066.9 6110.9 6118.5 6092.4 6100.0 6113.7 6116.5 6144.4 5676.8 5912.7 5917.1 5932.4 5933.5 5051.4 5899.9 5968.0 6118.0 6138.9 5943.0 5943.2 5960.8 5963.5 6019.1 17:58:02 INFO - PROCESS | 1959 | 17:58:02 INFO - PROCESS | 1959 | [#1] ext.html Cycles:180 Average:70932.91 Median:42909.29 stddev:154358.48 (359.7%) stddev-sans-first:154700.84 17:58:02 INFO - PROCESS | 1959 | Values: 471.2 475.2 486.7 523.3 566.0 30375.0 41572.0 41652.0 41736.2 43602.5 42604.1 42928.6 43127.8 43172.4 43186.8 9592.0 9767.6 9788.1 9790.3 9791.3 9622.9 9735.6 9737.6 9740.2 9744.9 9681.6 9724.9 9730.7 9741.0 9746.6 9697.0 9727.0 9728.5 9736.4 9740.8 9605.6 9679.2 9687.9 9690.8 9691.2 39081.8 39586.2 39638.6 39689.4 39818.8 3318.4 3541.5 3767.5 3934.4 4069.7 29773.7 31076.7 31227.0 31233.8 31267.2 3198.6 3319.3 3360.6 3367.8 3397.7 454255.0 456367.0 457171.0 457813.0 461889.0 59133.7 59998.8 60145.4 60183.7 62904.0 63143.4 63238.1 63321.7 63324.4 63346.0 15835.4 16051.7 16087.2 16111.6 16180.7 12419.7 12452.9 12463.1 12482.0 12489.4 14212.8 16686.8 17337.7 17341.6 17350.3 6900.0 6930.9 6938.7 6943.0 7009.6 793.4 811.8 993.3 1032.6 1090.3 26416.6 26941.6 33091.4 34168.7 34444.3 904.6 971.6 995.2 1092.3 1134.2 14722.6 15201.0 15405.5 15578.8 15802.8 658218.7 682546.0 682808.0 684767.0 685699.0 58261.1 58940.7 59057.0 59066.4 59089.7 1251.3 1289.8 1347.1 1388.9 1412.4 29973.7 29985.3 31057.8 31096.5 31218.8 50689.7 51251.7 51359.7 51367.5 51531.2 567030.0 575270.0 576289.0 577367.0 577543.0 42413.0 42890.0 43656.0 43713.8 44464.6 46774.3 47037.5 47260.0 48138.8 48638.0 39028.6 39187.4 39200.0 39568.6 40234.4 38744.4 39071.0 39811.8 40205.6 40550.0 37248.3 37863.4 38667.6 38701.8 38743.4 29971.3 34215.0 34896.0 35235.0 35305.3 21809.0 24886.4 25041.9 25649.2 25807.5 17:58:02 INFO - PROCESS | 1959 | 17:58:02 INFO - PROCESS | 1959 | [#2] jquery.html Cycles:180 Average:35207.39 Median:359.62 stddev:103996.77 (28918.7%) stddev-sans-first:104255.58 17:58:02 INFO - PROCESS | 1959 | Values: 353.3 366.0 376.1 381.7 400.9 14560.7 14675.5 15508.4 19426.6 20305.6 19415.1 19852.6 20488.9 20526.1 20771.7 5690.6 5938.6 6012.0 6015.8 6019.0 5677.3 5904.0 5968.7 5970.3 5975.9 3670.1 4353.5 5934.3 6129.8 6431.8 5696.9 6507.7 6529.1 6538.2 6570.5 5759.2 5868.3 5870.2 5872.7 5876.8 13037.2 14426.6 24105.8 24660.4 24981.8 1865.9 2012.3 2165.5 2208.9 2211.6 9530.2 10053.6 10171.9 10233.8 10379.9 1677.2 1751.1 1801.0 1824.7 1835.1 111557.0 115648.4 116149.0 117728.4 118113.6 9489.7 11268.9 11369.3 11502.2 11634.1 14493.9 14501.4 14508.5 14514.1 14527.3 8203.0 8374.8 8378.7 8499.1 8505.1 8238.3 8253.1 8276.5 8434.4 8460.2 3914.4 4480.5 4483.3 4560.6 4588.9 1850.4 1899.3 1911.0 1915.8 1922.6 715.8 823.9 839.9 901.0 952.9 19988.0 20487.5 20577.2 20584.2 20608.0 879.0 898.3 904.7 913.3 1006.2 8933.0 10197.2 10808.4 10826.9 10869.6 615573.0 617341.0 619702.7 630426.0 642538.0 92064.0 122565.0 126359.0 127206.0 128425.0 925.7 977.7 985.0 987.7 1001.0 13560.7 18608.9 19123.6 19259.9 19354.2 48065.5 54208.7 54530.7 55178.4 55702.9 78199.6 82280.6 82636.2 82636.3 83589.6 6618.7 8049.0 8174.1 8206.5 8218.7 9995.9 10954.2 12216.9 12478.3 12826.4 10760.9 10777.6 11113.7 11132.4 11224.3 10820.4 11018.7 11212.0 11284.6 11284.9 10920.6 11034.9 11152.2 11177.4 11414.9 7062.2 7345.4 7472.3 7901.9 8305.0 8283.2 9097.5 10471.7 11630.6 11682.9 17:58:02 INFO - PROCESS | 1959 | 17:58:02 INFO - PROCESS | 1959 | [#3] mootools.html Cycles:180 Average:5584.29 Median:4896.94 stddev:3137.19 (64.1%) stddev-sans-first:3129.83 17:58:02 INFO - PROCESS | 1959 | Values: 1347.2 1495.1 1523.1 1703.7 1859.8 7551.8 7993.1 7996.8 7997.2 8004.6 7826.0 8371.2 8594.5 8625.3 8654.5 2311.0 2344.9 2346.2 2346.8 2348.0 2293.4 2323.3 2335.8 2337.3 2339.2 2292.0 2314.4 2323.5 2326.4 2328.5 2221.0 2281.1 2308.4 2310.9 2312.0 1985.5 1999.3 2286.7 2288.4 2294.2 8515.4 8723.8 8734.5 8764.9 8766.6 4960.7 5116.5 5276.3 5286.7 5295.2 3213.6 3566.8 3661.2 3673.4 3674.4 1064.2 1075.9 1082.2 1094.5 1098.9 11420.3 11466.9 11475.8 11497.0 11501.8 4378.6 4562.7 4626.6 4798.7 4825.9 9071.5 9123.4 9131.0 9151.9 9163.1 5183.6 5232.1 5233.1 5241.3 5246.1 4359.8 4507.8 4721.7 4866.8 4915.4 3619.2 3673.5 3729.9 3762.5 3769.9 1123.2 1127.0 1129.7 1141.2 1147.3 742.2 796.6 893.5 901.6 934.5 5360.8 5548.0 5980.7 6015.8 6026.4 931.0 934.3 944.9 960.8 1000.0 3921.2 3946.8 3957.5 4056.7 4091.7 10389.3 10711.9 10725.3 10738.9 10769.7 10619.3 10710.2 10712.0 10720.3 10750.6 7930.3 8069.4 8078.8 8103.3 8255.2 5451.9 5787.5 5801.4 5895.5 5961.9 9586.4 9978.7 10002.4 10013.0 10064.5 9960.5 9989.9 10100.8 10162.7 10294.8 6401.7 6904.3 7133.6 7188.0 7578.5 8078.3 8164.8 8254.9 8269.3 8283.9 7242.7 7319.2 7348.3 7399.6 7505.7 7087.5 7116.3 7128.6 7167.2 7264.1 6762.4 6789.4 6859.8 6872.0 6877.2 4724.1 4734.5 4750.8 4808.0 4911.1 4830.4 4884.7 4909.1 4982.6 5043.9 17:58:02 INFO - PROCESS | 1959 | 17:58:02 INFO - PROCESS | 1959 | [#4] prototype.html Cycles:180 Average:4438.75 Median:4990.45 stddev:1378.93 (27.6%) stddev-sans-first:1347.34 17:58:02 INFO - PROCESS | 1959 | Values: 299.0 300.2 307.2 312.9 315.0 4182.4 4376.4 5230.5 5233.3 5276.7 4141.6 4895.4 4982.9 4995.5 5078.2 3999.0 4032.3 4034.2 4036.3 4050.0 3989.4 4013.2 4028.2 4036.4 4064.1 3341.9 3343.7 3893.6 3964.3 4013.8 3653.6 3998.5 4007.0 4010.5 4011.3 2928.0 2959.9 3081.4 3482.4 3519.9 4502.9 4651.6 4871.8 5116.0 5188.8 4363.6 4527.9 4552.2 4598.3 4602.8 4867.6 5487.4 5526.3 5584.4 5609.4 3817.8 3870.2 3894.5 3902.7 3909.9 4759.0 5325.5 5706.0 5740.8 5874.3 3242.5 3323.8 3483.3 3792.2 3801.5 3852.7 3867.2 3881.3 3889.0 3890.4 3894.4 4514.2 4526.3 4536.5 4553.5 5303.2 5559.3 5562.0 5579.5 5659.9 1124.7 1177.0 1220.0 1255.2 1287.6 823.6 843.1 855.3 870.4 886.0 5183.6 5225.0 5241.7 5253.7 5256.4 4744.4 5323.3 5506.6 5619.2 5652.0 4044.6 4914.7 5047.8 5064.5 5142.8 2643.7 2794.2 2860.4 2926.7 2940.5 5441.5 5703.7 5744.4 5755.3 5761.9 4577.9 4985.4 5565.3 5694.9 5743.2 5316.8 5719.3 5773.8 5830.5 5831.5 4320.4 4896.9 5603.7 5606.7 5658.1 4921.7 5445.3 5598.7 5643.8 5668.3 5158.7 5273.8 5390.8 5656.2 5896.9 3383.7 3495.6 3784.9 3795.7 3845.2 4754.6 5707.3 5727.2 5756.0 5776.7 5579.5 5587.2 5603.8 5605.2 5610.9 5234.7 5502.6 5565.3 5593.7 5649.0 4403.9 4651.7 5188.3 5337.1 5509.3 5262.2 5472.8 5481.0 5565.7 5606.6 5184.9 5459.9 5460.6 5460.7 5473.5 17:58:02 INFO - PROCESS | 1959 | 17:58:02 INFO - PROCESS | 1959 | [#5] yui.html Cycles:180 Average:25970.48 Median:3581.23 stddev:42615.00 (1190.0%) stddev-sans-first:42692.24 17:58:02 INFO - PROCESS | 1959 | Values: 682.0 751.0 770.4 786.3 788.2 15058.9 15699.3 15739.7 15747.3 16043.4 14047.7 14184.8 14199.9 14214.1 14261.1 670.9 691.0 819.8 821.6 843.7 837.9 838.7 840.1 841.0 841.0 889.3 890.5 890.7 890.7 891.3 701.4 725.9 859.4 870.7 884.7 631.4 632.1 644.3 656.8 658.4 12834.0 14586.8 14937.7 15010.6 15059.2 13566.5 13825.6 13934.2 13937.2 14099.6 12208.1 12231.1 12360.3 12421.1 12432.3 3907.7 4658.0 4665.4 4666.4 4671.6 113801.0 118197.0 121211.0 121337.0 121558.4 10702.5 11079.7 11089.8 11102.9 11149.7 21632.7 22397.8 22408.9 22428.0 22444.4 7793.9 7831.6 8027.5 8132.6 8180.5 4346.7 4356.9 4372.8 4384.1 4419.1 3479.8 3565.8 3577.8 3584.6 3590.2 625.4 626.9 627.6 642.0 648.2 522.2 603.6 603.9 612.2 627.6 7587.6 8928.4 9006.5 9020.5 9167.0 567.7 569.9 612.2 622.2 631.2 4435.2 4467.4 4468.7 4470.2 4592.0 122651.2 158661.0 158806.2 161075.0 164407.0 145426.0 147016.3 147878.5 148680.0 149195.0 119653.4 120006.4 121477.0 122255.4 126289.0 7121.4 7912.5 8047.8 8564.3 8722.9 62292.7 65144.7 65760.0 66091.7 67849.6 65057.3 79215.4 87534.1 95454.4 97031.0 10945.7 13233.9 13289.3 13430.6 13642.2 14139.4 14593.5 14618.2 14756.3 15428.2 13838.2 13904.0 13956.5 13987.5 14095.5 13342.1 13599.1 14009.3 14203.4 14471.7 13043.5 13571.9 13705.7 14005.6 14175.6 10827.8 10961.0 11228.6 11243.5 11661.5 9512.7 9841.5 10034.7 10511.4 11378.4 17:58:02 INFO - PROCESS | 1959 | -------- Summary: end -------- 17:58:02 INFO - PROCESS | 1959 | 17:58:02 INFO - TEST-INFO | 1959: exit 0 17:58:02 INFO - TEST-OK | dromaeo_css | took 1120598ms 17:58:02 INFO - TEST-START | kraken 17:58:02 INFO - operating with platform_type : mac_ 17:58:02 INFO - Initialising browser for kraken test... 17:58:02 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmp12ZWuB/profile http://localhost:52053/getInfo.html) 17:58:05 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 17:58:05 INFO - PROCESS | 1965 | colorDepth:24 17:58:05 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 17:58:05 INFO - PROCESS | 1965 | __metrics 17:58:05 INFO - PROCESS | 1965 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:58:05 INFO - PROCESS | 1965 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:58:06 INFO - TEST-INFO | 1965: exit 0 17:58:06 INFO - Browser initialized. 17:58:06 INFO - Running cycle 1/1 for kraken test... 17:58:06 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmp12ZWuB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:18 INFO - PROCESS | 1966 | RSS: Main: 245563392 17:58:18 INFO - PROCESS | 1966 | 17:58:20 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52053/tests/kraken/driver.html?testName=audio-beat-detection) 17:58:21 INFO - PROCESS | 1966 | RSS: Main: 295452672 17:58:21 INFO - PROCESS | 1966 | 17:58:24 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52053/tests/kraken/driver.html?testName=audio-dft) 17:58:25 INFO - PROCESS | 1966 | RSS: Main: 295530496 17:58:25 INFO - PROCESS | 1966 | 17:58:28 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52053/tests/kraken/driver.html?testName=audio-fft) 17:58:29 INFO - PROCESS | 1966 | RSS: Main: 387149824 17:58:29 INFO - PROCESS | 1966 | 17:58:31 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52053/tests/kraken/driver.html?testName=audio-oscillator) 17:58:32 INFO - PROCESS | 1966 | RSS: Main: 290439168 17:58:32 INFO - PROCESS | 1966 | 17:58:34 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52053/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:58:34 INFO - PROCESS | 1966 | RSS: Main: 292139008 17:58:34 INFO - PROCESS | 1966 | 17:58:37 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52053/tests/kraken/driver.html?testName=imaging-darkroom) 17:58:38 INFO - PROCESS | 1966 | RSS: Main: 330629120 17:58:38 INFO - PROCESS | 1966 | 17:58:40 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52053/tests/kraken/driver.html?testName=imaging-desaturate) 17:58:41 INFO - PROCESS | 1966 | RSS: Main: 330649600 17:58:41 INFO - PROCESS | 1966 | 17:58:44 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52053/tests/kraken/driver.html?testName=json-parse-financial) 17:58:44 INFO - PROCESS | 1966 | RSS: Main: 331513856 17:58:44 INFO - PROCESS | 1966 | 17:58:46 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52053/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:58:47 INFO - PROCESS | 1966 | RSS: Main: 301543424 17:58:47 INFO - PROCESS | 1966 | 17:58:48 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52053/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:58:49 INFO - PROCESS | 1966 | RSS: Main: 305676288 17:58:49 INFO - PROCESS | 1966 | 17:58:51 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52053/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:58:52 INFO - PROCESS | 1966 | RSS: Main: 310624256 17:58:52 INFO - PROCESS | 1966 | 17:58:55 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52053/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:58:56 INFO - PROCESS | 1966 | RSS: Main: 319565824 17:58:56 INFO - PROCESS | 1966 | 17:58:58 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52053/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:58:59 INFO - PROCESS | 1966 | RSS: Main: 317943808 17:58:59 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:52053/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52053/tests/kraken/driver.html?testName=ai-astar) 17:59:01 INFO - PROCESS | 1966 | RSS: Main: 361586688 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | __start_tp_report 17:59:01 INFO - PROCESS | 1966 | _x_x_mozilla_page_load 17:59:01 INFO - PROCESS | 1966 | _x_x_mozilla_page_load_details 17:59:01 INFO - PROCESS | 1966 | |i|pagename|runs| 17:59:01 INFO - PROCESS | 1966 | |0;ai-astar;112;113;113;112;113;113;112;113;112;113 17:59:01 INFO - PROCESS | 1966 | |1;audio-beat-detection;149;114;114;148;110;114;117;116;146;113 17:59:01 INFO - PROCESS | 1966 | |2;audio-dft;183;182;184;184;184;185;185;183;193;257 17:59:01 INFO - PROCESS | 1966 | |3;audio-fft;78;59;58;91;76;82;81;74;85;59 17:59:01 INFO - PROCESS | 1966 | |4;audio-oscillator;85;71;94;71;67;68;93;67;69;92 17:59:01 INFO - PROCESS | 1966 | |5;imaging-gaussian-blur;89;87;90;88;90;84;92;87;91;87 17:59:01 INFO - PROCESS | 1966 | |6;imaging-darkroom;95;95;95;96;96;95;96;95;95;106 17:59:01 INFO - PROCESS | 1966 | |7;imaging-desaturate;84;85;84;87;86;85;85;85;86;85 17:59:01 INFO - PROCESS | 1966 | |8;json-parse-financial;55;53;54;54;53;54;54;54;55;53 17:59:01 INFO - PROCESS | 1966 | |9;json-stringify-tinderbox;71;69;66;81;76;71;69;71;69;73 17:59:01 INFO - PROCESS | 1966 | |10;stanford-crypto-aes;87;85;87;90;88;86;86;86;87;91 17:59:01 INFO - PROCESS | 1966 | |11;stanford-crypto-ccm;159;147;155;154;138;145;163;150;208;146 17:59:01 INFO - PROCESS | 1966 | |12;stanford-crypto-pbkdf2;171;171;172;172;173;170;171;173;169;171 17:59:01 INFO - PROCESS | 1966 | |13;stanford-crypto-sha256-iterative;68;67;69;69;68;69;66;70;69;70 17:59:01 INFO - PROCESS | 1966 | __end_tp_report 17:59:01 INFO - PROCESS | 1966 | __start_cc_report 17:59:01 INFO - PROCESS | 1966 | _x_x_mozilla_cycle_collect,2025 17:59:01 INFO - PROCESS | 1966 | __end_cc_report 17:59:01 INFO - PROCESS | 1966 | __startTimestamp1476752341603__endTimestamp 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | ------- Summary: start ------- 17:59:01 INFO - PROCESS | 1966 | Number of tests: 14 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:59:01 INFO - PROCESS | 1966 | Values: 112.0 113.0 113.0 112.0 113.0 113.0 112.0 113.0 112.0 113.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:116.50 stddev:16.38 (14.1%) stddev-sans-first:14.69 17:59:01 INFO - PROCESS | 1966 | Values: 149.0 114.0 114.0 148.0 110.0 114.0 117.0 116.0 146.0 113.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#2] audio-dft Cycles:10 Average:192.00 Median:184.50 stddev:23.04 (12.5%) stddev-sans-first:24.21 17:59:01 INFO - PROCESS | 1966 | Values: 183.0 182.0 184.0 184.0 184.0 185.0 185.0 183.0 193.0 257.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#3] audio-fft Cycles:10 Average:74.30 Median:79.50 stddev:11.78 (14.8%) stddev-sans-first:12.41 17:59:01 INFO - PROCESS | 1966 | Values: 78.0 59.0 58.0 91.0 76.0 82.0 81.0 74.0 85.0 59.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:11.77 (15.1%) stddev-sans-first:12.18 17:59:01 INFO - PROCESS | 1966 | Values: 85.0 71.0 94.0 71.0 67.0 68.0 93.0 67.0 69.0 92.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.50 stddev:2.37 (2.6%) stddev-sans-first:2.51 17:59:01 INFO - PROCESS | 1966 | Values: 89.0 87.0 90.0 88.0 90.0 84.0 92.0 87.0 91.0 87.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:95.00 stddev:3.41 (3.6%) stddev-sans-first:3.57 17:59:01 INFO - PROCESS | 1966 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 106.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 17:59:01 INFO - PROCESS | 1966 | Values: 84.0 85.0 84.0 87.0 86.0 85.0 85.0 85.0 86.0 85.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 17:59:01 INFO - PROCESS | 1966 | Values: 55.0 53.0 54.0 54.0 53.0 54.0 54.0 54.0 55.0 53.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.00 stddev:4.25 (6.0%) stddev-sans-first:4.50 17:59:01 INFO - PROCESS | 1966 | Values: 71.0 69.0 66.0 81.0 76.0 71.0 69.0 71.0 69.0 73.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.00 stddev:1.89 (2.2%) stddev-sans-first:2.00 17:59:01 INFO - PROCESS | 1966 | Values: 87.0 85.0 87.0 90.0 88.0 86.0 86.0 86.0 87.0 91.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#11] stanford-crypto-ccm Cycles:10 Average:156.50 Median:154.50 stddev:19.51 (12.6%) stddev-sans-first:20.67 17:59:01 INFO - PROCESS | 1966 | Values: 159.0 147.0 155.0 154.0 138.0 145.0 163.0 150.0 208.0 146.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:1.25 (0.7%) stddev-sans-first:1.32 17:59:01 INFO - PROCESS | 1966 | Values: 171.0 171.0 172.0 172.0 173.0 170.0 171.0 173.0 169.0 171.0 17:59:01 INFO - PROCESS | 1966 | 17:59:01 INFO - PROCESS | 1966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.27 (1.8%) stddev-sans-first:1.33 17:59:01 INFO - PROCESS | 1966 | Values: 68.0 67.0 69.0 69.0 68.0 69.0 66.0 70.0 69.0 70.0 17:59:01 INFO - PROCESS | 1966 | -------- Summary: end -------- 17:59:01 INFO - PROCESS | 1966 | 17:59:02 INFO - TEST-INFO | 1966: exit 0 17:59:02 INFO - TEST-OK | kraken | took 59542ms 17:59:02 INFO - SUITE-END | took 1180s 17:59:02 INFO - Completed test suite (00:19:40) 17:59:02 INFO - javascript benchmark 17:59:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.8169700666463, 3331.2338162222695, 3338.5326054352395, 3372.2749608834097, 3392.5759280089987, 5410.83767486976, 5568.0, 5696.572757043217, 5740.684262365568, 5768.653880767151, 4167.354060120679, 5655.236543066685, 5780.901628690546, 5796.362400135981, 5808.303003639569, 5122.0, 5138.640295179339, 5154.252633368159, 5189.299444574972, 5219.42586315505, 5179.19722443022, 5268.446813084628, 5271.551918086967, 5280.9207861882105, 5292.894142117156, 5148.176291793333, 5220.686758794446, 5231.372235331784, 5234.0, 5340.145576707728, 4312.3531470279395, 5218.869528261824, 5228.215767634847, 5235.73821308933, 5237.554807841338, 5114.46542133335, 5184.248283998799, 5196.76614552346, 5197.974010129963, 5220.321358223445, 5720.2849643794525, 5724.16999535065, 5729.799457019026, 5729.885402291972, 5736.082226843685, 4572.588467037949, 6137.660235595016, 6150.862090513225, 6159.983602705548, 6170.382961703794, 6102.671035646916, 6104.541389247765, 6111.969440152815, 6121.510279177655, 6142.539309551801, 5579.191017302509, 5633.126865335879, 5650.406707295716, 5650.463205995424, 5657.519110875622, 5632.774689012475, 6211.627302361872, 6260.780872669435, 6270.122182894398, 6272.749090036439, 5106.872328191825, 6153.938460615336, 6159.137720719103, 6160.10678451631, 6165.5375846810775, 6115.909724157157, 6129.816105516842, 6141.148492690724, 6144.4945988232275, 6245.96877015612, 6165.876682466325, 6177.722002509898, 6202.627842329474, 6211.534134939898, 6215.502759779207, 6210.285817130997, 6226.377362263737, 6226.533010024266, 6241.937580624226, 6252.906206406908, 4804.183288840835, 4905.9264111038365, 4907.312976183337, 4924.384451943507, 4959.330490383824, 4323.7621930793475, 4363.083752411965, 4393.670474714345, 4396.912061758747, 4454.064646424287, 5760.308762948473, 5774.220480235199, 5781.739821708034, 5782.0, 5790.913136302959, 6248.9062664060075, 6294.559380843297, 6295.338989406138, 6301.306856245901, 6303.369663033752, 5594.692291923983, 5658.7170641467765, 5666.320041594952, 5720.256366672306, 5822.621529600562, 4542.273236282245, 5310.8141215057285, 5374.48942350476, 5410.486003829708, 5449.073657478239, 6270.122182894307, 6272.2159730033745, 6278.780242691484, 6281.183446151971, 6282.057691346335, 6100.611450805989, 6151.108089327112, 6154.83058218937, 6241.812745617639, 6282.089097080989, 6206.379362063757, 6245.875082498415, 6266.843328916813, 6287.591306565058, 6317.084022816574, 5994.250718660168, 6017.2779266488305, 6023.728932198149, 6025.0, 6068.271807383142, 6037.003894357382, 6122.326544080237, 6132.9386706134155, 6145.477634401126, 6153.815385538441, 5951.91072133927, 6064.241969753781, 6066.938285799879, 6110.908336374869, 6118.497354392036, 6092.421219984094, 6100.0, 6113.663748493876, 6116.541259405473, 6144.354842741448, 5676.829695109153, 5912.674802885883, 5917.112433135064, 5932.377100404568, 5933.495652869382, 5051.419086804917, 5899.911501327398, 5968.045112781934, 6118.0, 6138.917619782973, 5943.0, 5943.227380440515, 5960.821175364746, 5963.4632883039, 6019.067044608093], "value": 5635.073069310566, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.2201306837185, 475.23012719394586, 486.68122379841196, 523.3379774585151, 565.9688717120557, 30375.0, 41572.0, 41652.0, 41736.165276694446, 43602.473913413036, 42604.147917041715, 42928.57071429285, 43127.78436107823, 43172.3524147138, 43186.7840660797, 9592.040795920422, 9767.560459779326, 9788.070133337322, 9790.265730070238, 9791.265655075862, 9622.855657165148, 9735.561899714494, 9737.561809718543, 9740.220782337396, 9744.902550974506, 9681.564329605184, 9724.902750972506, 9730.708078757649, 9741.025897410273, 9746.610135594603, 9697.0, 9726.9513652432, 9728.513574321256, 9736.367136136128, 9740.805183896282, 9605.615775368977, 9679.225661947097, 9687.903120968842, 9690.75773105671, 9691.224702023892, 39081.804590977146, 39586.20827583461, 39638.60361396378, 39689.404658930136, 39818.80090599557, 3318.4026875162463, 3541.4510750833406, 3767.5290588676417, 3934.390169523728, 4069.674426045909, 29773.70226297731, 31076.68923310783, 31227.0, 31233.8438307807, 31267.218319541968, 3198.616166060064, 3319.2697606526526, 3360.5631267935255, 3367.8316084195694, 3397.69420752131, 454254.9999999967, 456367.0, 457171.0, 457813.0, 461889.0, 59133.70433147807, 59998.80002400015, 60145.398546014854, 60183.69908150431, 62904.0, 63143.36856631467, 63238.051429228595, 63321.683391582745, 63324.36675633277, 63346.0, 15835.366585336687, 16051.678966420606, 16087.195640217942, 16111.597210069842, 16180.67638647244, 12419.689507762198, 12452.875471245352, 12463.065270104778, 12482.0, 12489.437975290952, 14212.786808197885, 16686.83313166853, 17337.739933901, 17341.56646083858, 17350.3059877606, 6900.0, 6930.93069069313, 6938.653067346612, 6943.0, 7009.579425234502, 793.412874472886, 811.8213992921548, 993.3344659078434, 1032.6127702111708, 1090.3076546393097, 26416.603750943752, 26941.595876061874, 33091.43686502169, 34168.65831341704, 34444.311113777585, 904.5929331800716, 971.6437638726202, 995.2436148527026, 1092.3282181458346, 1134.2230572058002, 14722.55832325032, 15201.011934224462, 15405.537833865003, 15578.844211557966, 15802.841971580367, 658218.7226596675, 682546.0, 682808.0, 684767.0, 685699.0, 58261.126083108786, 58940.7052964741, 59057.0, 59066.40933590609, 59089.70455147697, 1251.3117785218094, 1289.8000809874297, 1347.070521340272, 1388.8819450346834, 1412.3644360038024, 29973.700262997092, 29985.250368740955, 31057.844710776302, 31096.533551997192, 31218.843905781236, 50689.74655126701, 51251.743741282546, 51359.74320128375, 51367.48632513627, 51531.22703159531, 567030.0, 575270.0, 576289.0, 577367.0, 577543.0, 42413.0, 42890.0, 43656.0, 43713.754349478266, 44464.55535444604, 46774.298385523565, 47037.529624704686, 47260.0, 48138.75930620325, 48638.02723945572, 39028.6097139025, 39187.41218881662, 39200.01999950024, 39568.60431395649, 40234.39648405335, 38744.41883371808, 39071.0, 39811.80094099511, 40205.597944021356, 40550.0, 37248.32382542738, 37863.43204851874, 38667.613323866404, 38701.80649096736, 38743.418848717854, 29971.250718732204, 34215.0, 34896.0, 35235.0, 35305.29389412146, 21809.0, 24886.37784055413, 25041.87479062593, 25649.230523084338, 25807.483850323264], "value": 20237.588198228674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.2793102071774, 365.9560852697675, 376.13113707336055, 381.6660422130636, 400.9478767760191, 14560.70878582429, 14675.486357977474, 15508.379664813394, 19426.611467770635, 20305.59388812223, 19415.12631931563, 19852.60294794103, 20488.8975555122, 20526.076326565304, 20771.68842467364, 5690.60165788396, 5938.61399009063, 6011.969940150315, 6015.75936962521, 6018.969905150469, 5677.347105082907, 5904.0, 5968.731407086691, 5970.253718285215, 5975.940240597603, 3670.137517683342, 4353.5211126776185, 5934.287885453751, 6129.785457508988, 6431.774887878925, 5696.914546281809, 6507.707153178095, 6529.053287273367, 6538.150040494753, 6570.540062195648, 5759.1937128802, 5868.295804503444, 5870.236869207019, 5872.677002764846, 5876.823695289148, 13037.217766934014, 14426.639334016629, 24105.758942410528, 24660.383490412703, 24981.750182498123, 1865.9440216793519, 2012.3459875540361, 2165.53441010182, 2208.933731988043, 2211.590855691702, 9530.237580993573, 10053.648122315757, 10171.949140254252, 10233.846492302622, 10379.89620103797, 1677.178182690485, 1751.106935462923, 1800.9819901800945, 1824.6533158699938, 1835.1191428114446, 111557.0, 115648.42175789067, 116149.0, 117728.41135794266, 118113.59807220205, 9489.667861624948, 11268.943655281671, 11369.31784092957, 11502.177428154711, 11634.149633339886, 14493.92753036249, 14501.419943202365, 14508.492202772852, 14514.056586321854, 14527.273636318141, 8202.958985205156, 8374.832503349899, 8378.748637540884, 8499.107593702696, 8505.106963768716, 8238.340932725368, 8253.09215986241, 8276.544790036485, 8434.439628668715, 8460.196281353385, 3914.3541315683165, 4480.484744254387, 4483.260262056724, 4560.566746159109, 4588.908221835612, 1850.3708739028796, 1899.2972600137762, 1910.9713354299697, 1915.817997290283, 1922.6154769046248, 715.7924201981367, 823.872299793533, 839.886615306938, 900.9773906616037, 952.8946422150273, 19988.0, 20487.4878128048, 20577.176912923616, 20584.176632934814, 20607.969601519864, 879.0023323527714, 898.3262553085186, 904.7150147703452, 913.3469569258012, 1006.2151521812998, 8933.0, 10197.235207359477, 10808.351498910091, 10826.891731082746, 10869.619563315404, 615573.0, 617341.0, 619702.7193232425, 630426.0, 642538.0, 92064.0, 122565.0, 126359.0, 127206.0, 128425.0, 925.6528801699362, 977.726236653738, 985.0346660272972, 987.6641941739842, 1000.9599616015423, 13560.660983475493, 18608.906955465136, 19123.617527649647, 19259.90370048197, 19354.225830966603, 48065.5193448075, 54208.66847405461, 54530.72734636301, 55178.44821551894, 55702.88594228012, 78199.60900195462, 82280.58859705663, 82636.17363826526, 82636.3472730554, 83589.58205208935, 6618.702158402787, 8049.034115906129, 8174.141715119827, 8206.548639824628, 8218.712345067894, 9995.850062248926, 10954.233203675985, 12216.877831221575, 12478.313692746622, 12826.422810973716, 10760.89239107599, 10777.568897244022, 11113.722156946142, 11132.38771867555, 11224.326540407601, 10820.4048777318, 11018.724531886766, 11212.04697600713, 11284.605038823602, 11284.887151128383, 10920.563177472812, 11034.889651103385, 11152.219344645797, 11177.441127943408, 11414.94292528532, 7062.223155452999, 7345.378147076885, 7472.29013243741, 7901.920980790348, 8305.013593475045, 8283.17168283167, 9097.454152750855, 10471.68584942453, 11630.592929247436, 11682.88317116818], "value": 9279.840519409652, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.2186132043416, 1495.1253516692739, 1523.1318148655264, 1703.727403615421, 1859.804720504347, 7551.773446796598, 7993.080795708495, 7996.800079998003, 7997.200279972, 8004.639791209395, 7825.982622259113, 8371.246587807096, 8594.527300998443, 8625.309975201984, 8654.524001179949, 2310.9884450577724, 2344.9062037518565, 2346.2022912209845, 2346.77705617966, 2347.9765202348012, 2293.4495721026915, 2323.337848713117, 2335.824813139013, 2337.3221765688013, 2339.1695947938492, 2291.9656205156853, 2314.351981445198, 2323.53529294141, 2326.3718795925092, 2328.487732698812, 2220.9888950555305, 2281.1103669568884, 2308.4113551044543, 2310.861348319106, 2311.9884400578057, 1985.4639247403265, 1999.2502811445709, 2286.7141607299086, 2288.439332363565, 2294.219965211836, 8515.403921725481, 8723.825523489495, 8734.51960142192, 8764.912350876473, 8766.561671916379, 4960.727160006199, 5116.513931176532, 5276.28520730764, 5286.709230992294, 5295.232191332274, 3213.550102985584, 3566.7555608825674, 3661.21283923955, 3673.448982652597, 3674.4488326750934, 1064.1912146768511, 1075.8924107589257, 1082.2316155529504, 1094.5402930769096, 1098.9120870330435, 11420.31478111316, 11466.942665286704, 11475.827862582068, 11497.0, 11501.827472587918, 4378.64970802335, 4562.657800664963, 4626.629869610423, 4798.66409351349, 4825.927611085836, 9071.501067441353, 9123.361364704408, 9131.041240669634, 9151.90848091524, 9163.129502697233, 5183.637145399861, 5232.136697444879, 5233.136532472099, 5241.292425522582, 5246.108161612535, 4359.825606975749, 4507.81968721254, 4721.693089949143, 4866.78099485524, 4915.4347250065985, 3619.2218672985437, 3673.504076949631, 3729.9067523312133, 3762.529683789526, 3769.9444155635915, 1123.1856903744883, 1126.9887301127048, 1129.6554550861902, 1141.2125633312987, 1147.3402793393666, 742.1835980421494, 796.6295672512309, 893.4862454088925, 901.6123067081087, 934.5187228577288, 5360.758765855468, 5547.951364258505, 5980.699060873741, 6015.789447369321, 6026.397360263939, 930.9953450232841, 934.313279739391, 944.8960614332418, 960.8366577681811, 999.9600015999279, 3921.1569512554365, 3946.8223929923224, 3957.465742124834, 4056.6815784870037, 4091.652209562161, 10389.272750907516, 10711.946440267904, 10725.30285531438, 10738.892611073945, 10769.730756731144, 10619.256652034283, 10710.196735244888, 10712.0, 10720.303180293256, 10750.623728169476, 7930.325922296554, 8069.394795390369, 8078.757637270891, 8103.270705636403, 8255.215754503313, 5451.945480545144, 5787.508061814793, 5801.361850196559, 5895.498882595028, 5961.880762384815, 9586.376885502421, 9978.650747224103, 10002.399856008662, 10013.0, 10064.496775161359, 9960.452175130438, 9989.850152247867, 10100.797984040424, 10162.695119146438, 10294.794104118026, 6401.743930242738, 6904.275051119761, 7133.5719856808755, 7187.9640601796655, 7578.507397019176, 8078.272955434039, 8164.7550573482895, 8254.876176857231, 8269.338452923632, 8283.917160828314, 7242.710291588488, 7319.194888562148, 7348.265173482609, 7399.59302238382, 7505.662245199088, 7087.539309944837, 7116.252793456612, 7128.572285662877, 7167.1757747859665, 7264.055672762507, 6762.357576030269, 6789.388954994074, 6859.794206173823, 6872.037914691847, 6877.209120951155, 4724.05518896229, 4734.479207287127, 4750.762461876961, 4807.95192048089, 4911.091448082117, 4830.372051633265, 4884.731339776346, 4909.140900342497, 4982.626303027215, 5043.9464724047475], "value": 4482.317943468052, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.97907146499745, 300.19547612398765, 307.24264687545195, 312.8545226469691, 315.043841939713, 4182.351735480997, 4376.431063961684, 5230.503102205284, 5233.319668443107, 5276.736163191844, 4141.57115795051, 4895.388076490439, 4982.9252561211615, 4995.52542508462, 5078.19723997981, 3998.9800050999706, 4032.254033003889, 4034.2249410259537, 4036.253293140771, 4049.987503124219, 3989.4414781930554, 4013.1973605278913, 4028.1943611277716, 4036.374361973899, 4064.0652649890544, 3341.8779075287125, 3343.7325013998943, 3893.6301051400073, 3964.2666106770193, 4013.8193781279765, 3653.5615726112906, 3998.540167880673, 4006.959930400688, 4010.498687664042, 4011.29802284599, 2928.0, 2959.852007399643, 3081.4299354619243, 3482.3905816482015, 3519.9296014079832, 4502.851772797948, 4651.6045186443935, 4871.7846221494, 5115.974420127875, 5188.844334669966, 4363.563643635643, 4527.890666786626, 4552.203364411214, 4598.310253461974, 4602.79287432063, 4867.586255168315, 5487.42382049883, 5526.281583394133, 5584.385717571064, 5609.411011843779, 3817.8091095445116, 3870.1872606752618, 3894.4547763313158, 3902.687784977195, 3909.9413508797393, 4759.0, 5325.4940780625775, 5705.974379095403, 5740.827775166752, 5874.295084589834, 3242.4974129010043, 3323.7673362864366, 3483.268513612119, 3792.241551689673, 3801.5248093988253, 3852.730308878408, 3867.16855875988, 3881.262560113569, 3888.96111038886, 3890.396988466792, 3894.415837624379, 4514.187446259639, 4526.343680166357, 4536.457604414515, 4553.521880202531, 5303.1628078977565, 5559.33288005442, 5561.972190139023, 5579.540684775465, 5659.915101273484, 1124.7244425115898, 1176.952921883115, 1219.9817002744967, 1255.1653150654713, 1287.6137158852307, 823.5552801487249, 843.1315744782884, 855.3200205836375, 870.4081224767219, 885.9855465491976, 5183.637145399861, 5224.973875130676, 5241.711705856138, 5253.711045892513, 5256.369235691742, 4744.383230180124, 5323.3079699639575, 5506.64206826555, 5619.157126431068, 5651.971740141355, 4044.6157615026527, 4914.729689867092, 5047.798088076509, 5064.46823083571, 5142.794288228429, 2643.6959749628654, 2794.1896849913705, 2860.382749783966, 2926.7365937065765, 2940.4560156370712, 5441.455854414527, 5703.722208343742, 5744.396838331999, 5755.323824363718, 5761.8559536011935, 4577.908441831145, 4985.376827896513, 5565.276514053147, 5694.886102277931, 5743.167240750068, 5316.813911513079, 5719.252151587711, 5773.797917072882, 5830.475257226785, 5831.504322132666, 4320.364577607594, 4896.877578060577, 5603.691796951207, 5606.747696353592, 5658.094704847369, 4921.704697718148, 5445.346558413015, 5598.692071936082, 5643.830685079454, 5668.348139963957, 5158.724210126522, 5273.789048438173, 5390.757415916215, 5656.210339072749, 5896.8820623586425, 3383.7462190336314, 3495.563054618173, 3784.9243015140096, 3795.6963442923948, 3845.2117315949604, 4754.643401744814, 5707.315122185364, 5727.226824378656, 5756.0, 5776.7111644418455, 5579.46995035471, 5587.240019393878, 5603.7758489659955, 5605.187247848958, 5610.943890561042, 5234.743661521284, 5502.58730595199, 5565.276514053147, 5593.664380137205, 5648.977796878815, 4403.899025243689, 4651.650811415775, 5188.299579556862, 5337.092694241911, 5509.338879334506, 5262.210668399771, 5472.753726082256, 5480.972595136999, 5565.660603637785, 5606.551475881838, 5184.922226166535, 5459.863503412446, 5460.563154947516, 5460.689434535762, 5473.480019398151], "value": 3997.1914070118046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.9624920629365, 750.9774706758795, 770.4144849914063, 786.3119770201076, 788.2283274531369, 15058.934087796288, 15699.293531791069, 15739.685206295868, 15747.291371888265, 16043.35826566936, 14047.719045619082, 14184.787228191586, 14199.858001419983, 14214.147151170911, 14261.073030253026, 670.9463242940577, 691.0084029417801, 819.7581713394533, 821.6138414944982, 843.7173546861809, 837.8994520657529, 838.6980686952692, 840.1094839470151, 840.9663613455485, 841.0202114536557, 889.3463304471209, 890.4835195586577, 890.7194233816327, 890.7327801659509, 891.2780647675404, 701.4318402094294, 725.8838585826243, 859.3511898516642, 870.712664820614, 884.7434244069212, 631.4254028833785, 632.1276638239201, 644.3170239546096, 656.8489247473108, 658.4238791057825, 12834.0, 14586.781198282035, 14937.701245975128, 15010.624734381729, 15059.17174555399, 13566.45734170632, 13825.585232443043, 13934.163950162922, 13937.233452160128, 14099.577012689533, 12208.145429819917, 12231.143819932608, 12360.25838449696, 12421.130520863544, 12432.316222607753, 3907.7069219808627, 4658.0, 4665.393498845128, 4666.440027196758, 4671.579557839811, 113801.0, 118197.0, 121211.0, 121337.0, 121558.39220803839, 10702.464876756287, 11079.667609971713, 11089.778204435866, 11102.888971110186, 11149.665510034712, 21632.675509867364, 22397.776022239894, 22408.887955560444, 22428.0, 22444.438889027904, 7793.883091753628, 7831.647575858986, 8027.478213916193, 8132.55270960091, 8180.46826956246, 4346.739195648272, 4356.912861742748, 4372.825086996484, 4384.145091707151, 4419.138268037702, 3479.7912125272564, 3565.750397472204, 3577.821108944542, 3584.6415358464465, 3590.2281009583066, 625.3590070178104, 626.8683576448906, 627.5607075047485, 642.0177128992649, 648.1638686094979, 522.2271038862505, 603.5684485592823, 603.8912995660824, 612.1552257884091, 627.6171535363425, 7587.620618969029, 8928.375013749104, 9006.549672516348, 9020.458772473672, 9167.0, 567.7396180479329, 569.9316082070178, 612.2102487790789, 622.2408661433044, 631.1952260867431, 4435.157320109169, 4467.396901418332, 4468.687191896601, 4470.240059189946, 4591.95408045922, 122651.16023259658, 158661.0, 158806.2059689694, 161075.0, 164407.0, 145426.0, 147016.26491867471, 147878.52121478648, 148680.0, 149195.0, 119653.40173299251, 120006.3999679996, 121477.0, 122255.3887230576, 126289.0, 7121.433284677362, 7912.453742463927, 8047.839043218985, 8564.272036876935, 8722.869156962524, 62292.68853655703, 65144.67427662831, 65760.0, 66091.67816643737, 67849.61926722107, 65057.34942650513, 79215.415691687, 87534.1246587526, 95454.36365090637, 97031.0, 10945.726356841144, 13233.867661323264, 13289.278274477248, 13430.597082087554, 13642.181469111885, 14139.350359533846, 14593.489227876973, 14618.195999219719, 14756.262186890826, 15428.151451670266, 13838.23889686077, 13904.026718129633, 13956.511522096678, 13987.510437134652, 14095.506657266946, 13342.06605537603, 13599.116057456235, 14009.299535023412, 14203.360848762037, 14471.710565788835, 13043.478260869459, 13571.864281357455, 13705.657358566115, 14005.579832605039, 14175.64560885986, 10827.837582436112, 10961.0, 11228.55085796559, 11243.49404276826, 11661.475233614678, 9512.714618561455, 9841.45871977048, 10034.69895903124, 10511.369317840954, 11378.37418941933], "value": 7802.004986012625, "unit": "score"}], "name": "dromaeo_css", "value": 7272.523682055089, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 112.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 114.0, 114.0, 148.0, 110.0, 114.0, 117.0, 116.0, 146.0, 113.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 184.0, 184.0, 184.0, 185.0, 185.0, 183.0, 193.0, 257.0], "value": 192.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 58.0, 91.0, 76.0, 82.0, 81.0, 74.0, 85.0, 59.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 94.0, 71.0, 67.0, 68.0, 93.0, 67.0, 69.0, 92.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 88.0, 90.0, 84.0, 92.0, 87.0, 91.0, 87.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 106.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 87.0, 86.0, 85.0, 85.0, 85.0, 86.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 55.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 66.0, 81.0, 76.0, 71.0, 69.0, 71.0, 69.0, 73.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 90.0, 88.0, 86.0, 86.0, 86.0, 87.0, 91.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 147.0, 155.0, 154.0, 138.0, 145.0, 163.0, 150.0, 208.0, 146.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 172.0, 172.0, 173.0, 170.0, 171.0, 173.0, 169.0, 171.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 69.0, 68.0, 69.0, 66.0, 70.0, 69.0, 70.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1459.9, "alertThreshold": 2.0}]} 17:59:02 INFO - Return code: 0 17:59:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:59:02 INFO - # TBPL SUCCESS # 17:59:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:59:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:59:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:59:02 INFO - 2016-10-17 17:59:02.945 screenresolution[1970:19157] starting screenresolution argv=screenresolution get 17:59:02 INFO - 2016-10-17 17:59:02.948 screenresolution[1970:19157] Display 0: 1600x1200x32@60 17:59:02 INFO - 2016-10-17 17:59:02.954 screenresolution[1971:19160] starting screenresolution argv=screenresolution list 17:59:02 INFO - Available Modes on Display 0 17:59:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:59:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:59:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:59:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:59:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:59:03 INFO - Intel Iris: 17:59:03 INFO - Chipset Model: Intel Iris 17:59:03 INFO - Type: GPU 17:59:03 INFO - Bus: Built-In 17:59:03 INFO - VRAM (Dynamic, Max): 1536 MB 17:59:03 INFO - Vendor: Intel (0x8086) 17:59:03 INFO - Device ID: 0x0a2e 17:59:03 INFO - Revision ID: 0x0009 17:59:03 INFO - Displays: 17:59:03 INFO - Display: 17:59:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:59:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:59:03 INFO - Display Serial Number: 1600x1200 60 17:59:03 INFO - Main Display: Yes 17:59:03 INFO - Mirror: Off 17:59:03 INFO - Online: Yes 17:59:03 INFO - Rotation: Supported 17:59:03 INFO - Return code: 0 17:59:03 INFO - Running post-action listener: _resource_record_post_action 17:59:03 INFO - [mozharness: 2016-10-18 00:59:03.188755Z] Finished run-tests step (success) 17:59:03 INFO - Running post-run listener: _resource_record_post_run 17:59:03 INFO - Total resource usage - Wall time: 1217s; CPU: 54.0%; Read bytes: 712704; Write bytes: 706585600; Read time: 9; Write time: 2929 17:59:03 INFO - TinderboxPrint: CPU usage
53.6% 17:59:03 INFO - TinderboxPrint: I/O read bytes / time
712,704 / 9 17:59:03 INFO - TinderboxPrint: I/O write bytes / time
706,585,600 / 2,929 17:59:03 INFO - TinderboxPrint: CPU idle
2,259.7 (46.4%) 17:59:03 INFO - TinderboxPrint: CPU system
976.1 (20.1%) 17:59:03 INFO - TinderboxPrint: CPU user
1,629.9 (33.5%) 17:59:03 INFO - TinderboxPrint: Swap in / out
407,408,640 / 0 17:59:03 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 401373696; Write bytes: 397170688; Read time: 30935; Write time: 965 17:59:03 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 675840; Write bytes: 294198272; Read time: 8; Write time: 1920 17:59:03 INFO - Running post-run listener: _upload_blobber_files 17:59:03 INFO - Blob upload gear active. 17:59:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:59:03 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 17:59:03 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:59:03 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:59:04 INFO - (blobuploader) - INFO - Open directory for files ... 17:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:04 INFO - (blobuploader) - INFO - Done attempting. 17:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:05 INFO - (blobuploader) - INFO - Done attempting. 17:59:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:59:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:08 INFO - (blobuploader) - INFO - Done attempting. 17:59:08 INFO - (blobuploader) - INFO - Iteration through files over. 17:59:08 INFO - Return code: 0 17:59:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:59:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:59:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/47d85abbd9d97053661f52e39016070ebe7cb960d92b839abc9d420aee65a2ed99fcb39fd03ed6adb134f6ab8203b601cbc101fe3a78b67d4fe5bff6f306c861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c51399951543c688b242e82a59942cee3c3d69638d330b576df264593beb3a07e8ea8dab9ebf57f2540da49ccebe96112c4ff3c9660ed3d3f8684f504bd06f25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/cee2ddedfe845539f73d8a15a2146287fb7cc12f0542ef0bd1c1b3258b024ce40892f89e54020f38a70b667e2245b2f042064327ae0470778ecec9cabae64af7"} 17:59:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:59:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:59:08 INFO - Contents: 17:59:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/47d85abbd9d97053661f52e39016070ebe7cb960d92b839abc9d420aee65a2ed99fcb39fd03ed6adb134f6ab8203b601cbc101fe3a78b67d4fe5bff6f306c861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c51399951543c688b242e82a59942cee3c3d69638d330b576df264593beb3a07e8ea8dab9ebf57f2540da49ccebe96112c4ff3c9660ed3d3f8684f504bd06f25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/cee2ddedfe845539f73d8a15a2146287fb7cc12f0542ef0bd1c1b3258b024ce40892f89e54020f38a70b667e2245b2f042064327ae0470778ecec9cabae64af7"} 17:59:08 INFO - Running post-run listener: copy_logs_to_upload_dir 17:59:08 INFO - Copying logs to upload dir... 17:59:08 INFO - mkdir: /builds/slave/test/build/upload/logs 17:59:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.448486 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-17 17:59:08.917368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 17:59:08.921444) ========= 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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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/Larch/sha512/47d85abbd9d97053661f52e39016070ebe7cb960d92b839abc9d420aee65a2ed99fcb39fd03ed6adb134f6ab8203b601cbc101fe3a78b67d4fe5bff6f306c861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c51399951543c688b242e82a59942cee3c3d69638d330b576df264593beb3a07e8ea8dab9ebf57f2540da49ccebe96112c4ff3c9660ed3d3f8684f504bd06f25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/cee2ddedfe845539f73d8a15a2146287fb7cc12f0542ef0bd1c1b3258b024ce40892f89e54020f38a70b667e2245b2f042064327ae0470778ecec9cabae64af7"} build_url:https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011109 build_url: 'https://queue.taskcluster.net/v1/task/YHxElLvoQW-MaqNf6ha3AQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/47d85abbd9d97053661f52e39016070ebe7cb960d92b839abc9d420aee65a2ed99fcb39fd03ed6adb134f6ab8203b601cbc101fe3a78b67d4fe5bff6f306c861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c51399951543c688b242e82a59942cee3c3d69638d330b576df264593beb3a07e8ea8dab9ebf57f2540da49ccebe96112c4ff3c9660ed3d3f8684f504bd06f25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/cee2ddedfe845539f73d8a15a2146287fb7cc12f0542ef0bd1c1b3258b024ce40892f89e54020f38a70b667e2245b2f042064327ae0470778ecec9cabae64af7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 17:59:08.956869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:59:08.957434) ========= 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.OMB5Dm9c8H/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.HcwUN7gWnt/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005330 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:59:09.007531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 17:59:09.007880) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 17:59:09.008240) ========= ========= Total master_lag: 0.19 =========