builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0155 starttime: 1484909557.76 results: success (0) buildid: 20170120000424 builduid: 9cd368a617bb448e93d53233b1eb04c2 revision: b2e633d19d68a6777838d5730e3412d13de99474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:37.762957) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:37.763417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:37.763711) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:37.789515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:37.789786) ========= 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.1hxZ557g4s/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.ShKMfzNYRH/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 --2017-01-20 02:52:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 53.5M=0s 2017-01-20 02:52:37 (53.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123461 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:37.937081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:37.937385) ========= 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.1hxZ557g4s/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.ShKMfzNYRH/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.027982 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:37.986258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-20 02:52:37.986577) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b2e633d19d68a6777838d5730e3412d13de99474 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b2e633d19d68a6777838d5730e3412d13de99474 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1hxZ557g4s/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.ShKMfzNYRH/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 2017-01-20 02:52:38,077 truncating revision to first 12 chars 2017-01-20 02:52:38,077 Setting DEBUG logging. 2017-01-20 02:52:38,077 attempt 1/10 2017-01-20 02:52:38,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b2e633d19d68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 02:52:40,207 unpacking tar archive at: mozilla-aurora-b2e633d19d68/testing/mozharness/ program finished with exit code 0 elapsedTime=2.398578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-20 02:52:40.408763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:40.409098) ========= script_repo_revision: b2e633d19d68a6777838d5730e3412d13de99474 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:40.409526) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:40.409817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:40.431257) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-01-20 02:52:40.431877) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1hxZ557g4s/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.ShKMfzNYRH/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:52:40 INFO - MultiFileLogger online at 20170120 02:52:40 in /builds/slave/test 02:52:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:52:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:40 INFO - {'append_to_log': False, 02:52:40 INFO - 'base_work_dir': '/builds/slave/test', 02:52:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:52:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:40 INFO - 'branch': 'Mozilla-Aurora', 02:52:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:40 INFO - 'config_files': ('talos/mac_config.py',), 02:52:40 INFO - 'default_actions': ('clobber', 02:52:40 INFO - 'read-buildbot-config', 02:52:40 INFO - 'download-and-extract', 02:52:40 INFO - 'populate-webroot', 02:52:40 INFO - 'create-virtualenv', 02:52:40 INFO - 'install', 02:52:40 INFO - 'run-tests'), 02:52:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:40 INFO - 'download_minidump_stackwalk': True, 02:52:40 INFO - 'download_symbols': 'ondemand', 02:52:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:52:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:52:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:52:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:52:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:40 INFO - 'installer_path': 'installer.exe', 02:52:40 INFO - 'log_level': 'info', 02:52:40 INFO - 'log_name': 'talos', 02:52:40 INFO - 'log_to_console': True, 02:52:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:52:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:52:40 INFO - 'opt_config_files': (), 02:52:40 INFO - 'pip_index': False, 02:52:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:40 INFO - 'cmd': ('bash', 02:52:40 INFO - '-c', 02:52:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:40 INFO - 'enabled': True, 02:52:40 INFO - 'halt_on_failure': False, 02:52:40 INFO - 'name': 'check_screen_resolution'},), 02:52:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:40 INFO - 'cmd': ('bash', 02:52:40 INFO - '-c', 02:52:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:40 INFO - 'enabled': True, 02:52:40 INFO - 'halt_on_failure': False, 02:52:40 INFO - 'name': 'check_screen_resolution'},), 02:52:40 INFO - 'run_cmd_checks_enabled': True, 02:52:40 INFO - 'sps_profile': False, 02:52:40 INFO - 'sps_profile_interval': 0, 02:52:40 INFO - 'suite': 'dromaeojs', 02:52:40 INFO - 'system_bits': '32', 02:52:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:40 INFO - 'title': 't-yosemite-r7-0155', 02:52:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:40 INFO - 'use_talos_json': True, 02:52:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:40 INFO - 'work_dir': 'build'} 02:52:40 INFO - [mozharness: 2017-01-20 10:52:40.637480Z] Running clobber step. 02:52:40 INFO - Running pre-action listener: _resource_record_pre_action 02:52:40 INFO - Running main action method: clobber 02:52:40 INFO - rmtree: /builds/slave/test/build 02:52:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:43 INFO - Running post-action listener: _resource_record_post_action 02:52:43 INFO - [mozharness: 2017-01-20 10:52:43.110533Z] Finished clobber step (success) 02:52:43 INFO - [mozharness: 2017-01-20 10:52:43.110731Z] Running read-buildbot-config step. 02:52:43 INFO - Running pre-action listener: _resource_record_pre_action 02:52:43 INFO - Running main action method: read_buildbot_config 02:52:43 INFO - Using buildbot properties: 02:52:43 INFO - { 02:52:43 INFO - "project": "", 02:52:43 INFO - "product": "firefox", 02:52:43 INFO - "script_repo_revision": "production", 02:52:43 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:52:43 INFO - "repository": "", 02:52:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:52:43 INFO - "buildid": "20170120000424", 02:52:43 INFO - "pgo_build": "False", 02:52:43 INFO - "basedir": "/builds/slave/test", 02:52:43 INFO - "buildnumber": 93, 02:52:43 INFO - "slavename": "t-yosemite-r7-0155", 02:52:43 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 02:52:43 INFO - "platform": "yosemite_r7", 02:52:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:52:43 INFO - "branch": "mozilla-aurora", 02:52:43 INFO - "repo_path": "releases/mozilla-aurora", 02:52:43 INFO - "revision": "b2e633d19d68a6777838d5730e3412d13de99474", 02:52:43 INFO - "stage_platform": "macosx64", 02:52:43 INFO - "builduid": "9cd368a617bb448e93d53233b1eb04c2", 02:52:43 INFO - "slavebuilddir": "test" 02:52:43 INFO - } 02:52:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:52:43 INFO - Running post-action listener: _resource_record_post_action 02:52:43 INFO - [mozharness: 2017-01-20 10:52:43.116001Z] Finished read-buildbot-config step (success) 02:52:43 INFO - [mozharness: 2017-01-20 10:52:43.116210Z] Running download-and-extract step. 02:52:43 INFO - Running pre-action listener: _resource_record_pre_action 02:52:43 INFO - Running main action method: download_and_extract 02:52:43 INFO - mkdir: /builds/slave/test/build/tests 02:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:43 INFO - trying https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:52:43 INFO - Downloading https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 02:52:44 INFO - Downloaded 1199 bytes. 02:52:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:52:44 INFO - Using the following test package requirements: 02:52:44 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:52:44 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:44 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:52:44 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:44 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:52:44 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:44 INFO - u'jsshell-mac.zip'], 02:52:44 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:44 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:52:44 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:52:44 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:44 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:52:44 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:44 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:52:44 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:44 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:52:44 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:44 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:52:44 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:52:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:52:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:52:44 INFO - Fetch https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:52:44 INFO - Http code: 200 02:52:44 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 02:52:44 INFO - x-amz-cf-id: YkVRhfsMeYIMwNzED20-grIUAh92fGjFH0rbQ4otH57ABPfNlVZzqQ== 02:52:44 INFO - x-amz-version-id: eY8bQNGlI.ydpHa6o.0zpRIJ9t.NCQNH 02:52:44 INFO - Expected file size: 16276212 02:52:44 INFO - Obtained file size: 16276212 02:52:51 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:52:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:52:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:52:51 INFO - Fetch https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:52:52 INFO - Http code: 200 02:52:52 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 02:52:52 INFO - x-amz-cf-id: GdUlISh8kLJH18UayVAA8AfdHVt7EMCIiLy1vF8RvNqGiX9lZcvEkA== 02:52:52 INFO - x-amz-version-id: eY8bQNGlI.ydpHa6o.0zpRIJ9t.NCQNH 02:52:52 INFO - Expected file size: 16276212 02:52:52 INFO - Obtained file size: 16276212 02:52:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:52:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:52:59 INFO - Fetch https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:53:00 INFO - Http code: 200 02:53:00 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 02:53:00 INFO - x-amz-cf-id: ffLKnrgAlinCxE7KllI8HUBHs8DwxWCE9DB0mq06umRV6jIk5uroUQ== 02:53:00 INFO - x-amz-version-id: C.LmJcOUIW6sfRg9TRSnq_nwSeG.5j67 02:53:00 INFO - Expected file size: 14409038 02:53:00 INFO - Obtained file size: 14409038 02:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:00 INFO - trying https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:53:00 INFO - Downloading https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:53:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 02:53:03 INFO - Downloaded 109971447 bytes. 02:53:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:53:03 INFO - mkdir: /builds/slave/test/properties 02:53:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:53:03 INFO - Writing to file /builds/slave/test/properties/build_url 02:53:03 INFO - Contents: 02:53:03 INFO - build_url:https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:53:04 INFO - Running post-action listener: _resource_record_post_action 02:53:04 INFO - Running post-action listener: set_extra_try_arguments 02:53:04 INFO - [mozharness: 2017-01-20 10:53:04.554161Z] Finished download-and-extract step (success) 02:53:04 INFO - [mozharness: 2017-01-20 10:53:04.554285Z] Running populate-webroot step. 02:53:04 INFO - Running pre-action listener: _resource_record_pre_action 02:53:04 INFO - Running main action method: populate_webroot 02:53:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:53:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:53:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:53:04 INFO - '--tppagecycles', 02:53:04 INFO - '7'], 02:53:04 INFO - 'tests': ['tsvgm']}}, 02:53:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:53:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:53:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:53:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:53:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:04 INFO - 'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:53:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:53:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:04 INFO - 'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['damp', 'tps']}, 02:53:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:04 INFO - 'tests': ['damp', 'tps']}, 02:53:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['dromaeo_dom']}, 02:53:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:53:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['basic_compositor_video']}, 02:53:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:53:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['a11yr', 02:53:04 INFO - 'ts_paint', 02:53:04 INFO - 'tpaint', 02:53:04 INFO - 'sessionrestore', 02:53:04 INFO - 'sessionrestore_no_auto_restore', 02:53:04 INFO - 'tabpaint']}, 02:53:04 INFO - 'other-e10s': {'tests': ['a11yr', 02:53:04 INFO - 'ts_paint', 02:53:04 INFO - 'tpaint', 02:53:04 INFO - 'sessionrestore', 02:53:04 INFO - 'sessionrestore_no_auto_restore', 02:53:04 INFO - 'tabpaint']}, 02:53:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:53:04 INFO - 'ts_paint', 02:53:04 INFO - 'tpaint', 02:53:04 INFO - 'sessionrestore', 02:53:04 INFO - 'sessionrestore_no_auto_restore', 02:53:04 INFO - 'tabpaint']}, 02:53:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:53:04 INFO - 'ts_paint', 02:53:04 INFO - 'tpaint', 02:53:04 INFO - 'sessionrestore', 02:53:04 INFO - 'sessionrestore_no_auto_restore', 02:53:04 INFO - 'tabpaint']}, 02:53:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['a11yr', 02:53:04 INFO - 'ts_paint', 02:53:04 INFO - 'tpaint', 02:53:04 INFO - 'sessionrestore', 02:53:04 INFO - 'sessionrestore_no_auto_restore', 02:53:04 INFO - 'tabpaint']}, 02:53:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['a11yr', 02:53:04 INFO - 'ts_paint', 02:53:04 INFO - 'tpaint', 02:53:04 INFO - 'sessionrestore', 02:53:04 INFO - 'sessionrestore_no_auto_restore', 02:53:04 INFO - 'tabpaint']}, 02:53:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['tsvgx', 02:53:04 INFO - 'tsvgr_opacity', 02:53:04 INFO - 'tart', 02:53:04 INFO - 'tscrollx', 02:53:04 INFO - 'cart']}, 02:53:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:53:04 INFO - 'tsvgr_opacity', 02:53:04 INFO - 'tart', 02:53:04 INFO - 'tscrollx', 02:53:04 INFO - 'cart']}, 02:53:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:04 INFO - 'talos_options': ['--disable-e10s'], 02:53:04 INFO - 'tests': ['tp5o']}, 02:53:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:04 INFO - 'tests': ['tp5o']}, 02:53:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:04 INFO - 'talos_options': ['--disable-e10s', 02:53:04 INFO - '--xperf_path', 02:53:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:53:04 INFO - 'tests': ['tp5n']}, 02:53:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:04 INFO - 'talos_options': ['--xperf_path', 02:53:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:53:04 INFO - 'tests': ['tp5n']}}, 02:53:04 INFO - 'talos.zip': {'path': '', 02:53:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:53:04 INFO - Running post-action listener: _resource_record_post_action 02:53:04 INFO - [mozharness: 2017-01-20 10:53:04.572868Z] Finished populate-webroot step (success) 02:53:04 INFO - [mozharness: 2017-01-20 10:53:04.572976Z] Running create-virtualenv step. 02:53:04 INFO - Running pre-action listener: _resource_record_pre_action 02:53:04 INFO - Running main action method: create_virtualenv 02:53:04 INFO - Creating virtualenv /builds/slave/test/build/venv 02:53:04 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 02:53:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:53:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:53:04 INFO - Using real prefix '/tools/python27' 02:53:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:53:05 INFO - Installing distribute.............................................................................................................................................................................................done. 02:53:08 INFO - Installing pip.................done. 02:53:08 INFO - Return code: 0 02:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:53:08 INFO - Reading from file tmpfile_stdout 02:53:08 INFO - Output received: 02:53:08 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) 02:53:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:53:08 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')]} 02:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:08 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')]} 02:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:08 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 0x105e32490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105da8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cf2c52380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, '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.1hxZ557g4s/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.ShKMfzNYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:53:08 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 02:53:08 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 02:53:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:53:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:08 INFO - 'HOME': '/Users/cltbld', 02:53:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:08 INFO - 'LOGNAME': 'cltbld', 02:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:08 INFO - 'MOZ_NO_REMOTE': '1', 02:53:08 INFO - 'NO_EM_RESTART': '1', 02:53:08 INFO - 'PAGER': '/bin/cat', 02:53:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:08 INFO - 'PWD': '/builds/slave/test', 02:53:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:08 INFO - 'SHELL': '/bin/bash', 02:53:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:53:08 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:53:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:08 INFO - 'USER': 'cltbld', 02:53:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:08 INFO - 'XPC_FLAGS': '0x0', 02:53:08 INFO - 'XPC_SERVICE_NAME': '0', 02:53:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:08 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 02:53:08 INFO - Cleaning up... 02:53:08 INFO - Return code: 0 02:53:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:53:08 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')]} 02:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:08 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')]} 02:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:08 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 0x105e32490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105da8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cf2c52380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, '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.1hxZ557g4s/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.ShKMfzNYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:53:08 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 02:53:08 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 02:53:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:53:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:08 INFO - 'HOME': '/Users/cltbld', 02:53:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:08 INFO - 'LOGNAME': 'cltbld', 02:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:08 INFO - 'MOZ_NO_REMOTE': '1', 02:53:08 INFO - 'NO_EM_RESTART': '1', 02:53:08 INFO - 'PAGER': '/bin/cat', 02:53:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:08 INFO - 'PWD': '/builds/slave/test', 02:53:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:08 INFO - 'SHELL': '/bin/bash', 02:53:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:53:08 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:53:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:08 INFO - 'USER': 'cltbld', 02:53:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:08 INFO - 'XPC_FLAGS': '0x0', 02:53:08 INFO - 'XPC_SERVICE_NAME': '0', 02:53:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:09 INFO - Downloading/unpacking psutil>=3.1.1 02:53:09 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 02:53:09 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 02:53:09 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 02:53:09 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 02:53:09 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 02:53:09 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 02:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:53:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:12 INFO - Installing collected packages: psutil 02:53:12 INFO - Running setup.py install for psutil 02:53:12 INFO - building 'psutil._psutil_osx' extension 02:53:12 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 02:53:13 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 02:53:13 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 02:53:13 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 02:53:13 INFO - building 'psutil._psutil_posix' extension 02:53:13 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 02:53:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:53:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:53:13 INFO - ^ 02:53:13 INFO - 1 warning generated. 02:53:13 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 02:53:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:13 INFO - Successfully installed psutil 02:53:13 INFO - Cleaning up... 02:53:13 INFO - Return code: 0 02:53:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:53:13 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')]} 02:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:13 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')]} 02:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:13 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 0x105e32490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105da8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cf2c52380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, '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.1hxZ557g4s/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.ShKMfzNYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:53:13 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 02:53:13 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 02:53:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:53:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:13 INFO - 'HOME': '/Users/cltbld', 02:53:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:13 INFO - 'LOGNAME': 'cltbld', 02:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:13 INFO - 'MOZ_NO_REMOTE': '1', 02:53:13 INFO - 'NO_EM_RESTART': '1', 02:53:13 INFO - 'PAGER': '/bin/cat', 02:53:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:13 INFO - 'PWD': '/builds/slave/test', 02:53:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:13 INFO - 'SHELL': '/bin/bash', 02:53:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:53:13 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:53:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:13 INFO - 'USER': 'cltbld', 02:53:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:13 INFO - 'XPC_FLAGS': '0x0', 02:53:13 INFO - 'XPC_SERVICE_NAME': '0', 02:53:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:53:14 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 02:53:14 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 02:53:14 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 02:53:14 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 02:53:14 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 02:53:14 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 02:53:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:53:16 INFO - Installing collected packages: mozsystemmonitor 02:53:16 INFO - Running setup.py install for mozsystemmonitor 02:53:17 INFO - Successfully installed mozsystemmonitor 02:53:17 INFO - Cleaning up... 02:53:17 INFO - Return code: 0 02:53:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e32490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105da8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cf2c52380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, '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.1hxZ557g4s/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.ShKMfzNYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:53:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:53:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:17 INFO - 'HOME': '/Users/cltbld', 02:53:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:17 INFO - 'LOGNAME': 'cltbld', 02:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:17 INFO - 'MOZ_NO_REMOTE': '1', 02:53:17 INFO - 'NO_EM_RESTART': '1', 02:53:17 INFO - 'PAGER': '/bin/cat', 02:53:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:17 INFO - 'PWD': '/builds/slave/test', 02:53:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:17 INFO - 'SHELL': '/bin/bash', 02:53:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:53:17 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:53:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:17 INFO - 'USER': 'cltbld', 02:53:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:17 INFO - 'XPC_FLAGS': '0x0', 02:53:17 INFO - 'XPC_SERVICE_NAME': '0', 02:53:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:17 INFO - Downloading/unpacking jsonschema==2.5.1 02:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:53:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:53:20 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 02:53:20 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 02:53:20 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 02:53:20 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 02:53:20 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 02:53:20 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 02:53:20 INFO - Downloading functools32-3.2.3-2.tar.gz 02:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:53:20 INFO - warning: no files found matching '*.txt' 02:53:20 INFO - no previously-included directories found matching 'build' 02:53:20 INFO - no previously-included directories found matching 'dist' 02:53:20 INFO - no previously-included directories found matching '.git*' 02:53:20 INFO - Installing collected packages: jsonschema, functools32 02:53:20 INFO - Running setup.py install for functools32 02:53:20 INFO - warning: no files found matching '*.txt' 02:53:20 INFO - no previously-included directories found matching 'build' 02:53:20 INFO - no previously-included directories found matching 'dist' 02:53:20 INFO - no previously-included directories found matching '.git*' 02:53:20 INFO - Successfully installed jsonschema functools32 02:53:20 INFO - Cleaning up... 02:53:20 INFO - Return code: 0 02:53:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:20 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 0x105e32490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105da8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cf2c52380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, '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.1hxZ557g4s/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.ShKMfzNYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:53:20 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 02:53:20 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 02:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:20 INFO - 'HOME': '/Users/cltbld', 02:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:20 INFO - 'LOGNAME': 'cltbld', 02:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:20 INFO - 'MOZ_NO_REMOTE': '1', 02:53:20 INFO - 'NO_EM_RESTART': '1', 02:53:20 INFO - 'PAGER': '/bin/cat', 02:53:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:20 INFO - 'PWD': '/builds/slave/test', 02:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:20 INFO - 'SHELL': '/bin/bash', 02:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:53:20 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:20 INFO - 'USER': 'cltbld', 02:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:20 INFO - 'XPC_FLAGS': '0x0', 02:53:20 INFO - 'XPC_SERVICE_NAME': '0', 02:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:53:21 INFO - Cleaning up... 02:53:21 INFO - Return code: 0 02:53:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e32490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105da8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cf2c52380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, '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.1hxZ557g4s/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.ShKMfzNYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:53:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:53:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:53:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:21 INFO - 'HOME': '/Users/cltbld', 02:53:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:21 INFO - 'LOGNAME': 'cltbld', 02:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:21 INFO - 'MOZ_NO_REMOTE': '1', 02:53:21 INFO - 'NO_EM_RESTART': '1', 02:53:21 INFO - 'PAGER': '/bin/cat', 02:53:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:21 INFO - 'PWD': '/builds/slave/test', 02:53:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:21 INFO - 'SHELL': '/bin/bash', 02:53:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:53:21 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:53:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:21 INFO - 'USER': 'cltbld', 02:53:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:21 INFO - 'XPC_FLAGS': '0x0', 02:53:21 INFO - 'XPC_SERVICE_NAME': '0', 02:53:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:21 INFO - Downloading/unpacking blobuploader==1.2.4 02:53:21 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 02:53:21 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 02:53:21 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 02:53:21 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 02:53:21 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 02:53:21 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 02:53:24 INFO - Downloading blobuploader-1.2.4.tar.gz 02:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:53:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:53: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 02:53: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 02:53: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 02:53: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 02:53: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 02:53: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 02:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:53:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:53: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 02:53: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 02:53: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 02:53: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 02:53: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 02:53: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 02:53:25 INFO - Downloading docopt-0.6.1.tar.gz 02:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:53:25 INFO - Installing collected packages: blobuploader, requests, docopt 02:53:25 INFO - Running setup.py install for blobuploader 02:53:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:53:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:53:25 INFO - Running setup.py install for requests 02:53:26 INFO - Running setup.py install for docopt 02:53:26 INFO - Successfully installed blobuploader requests docopt 02:53:26 INFO - Cleaning up... 02:53:26 INFO - Return code: 0 02:53:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:26 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')]} 02:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:26 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')]} 02:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:26 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 0x105e32490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105da8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cf2c52380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, '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.1hxZ557g4s/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.ShKMfzNYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:53:26 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 02:53:26 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 02:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:26 INFO - 'HOME': '/Users/cltbld', 02:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:26 INFO - 'LOGNAME': 'cltbld', 02:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:26 INFO - 'MOZ_NO_REMOTE': '1', 02:53:26 INFO - 'NO_EM_RESTART': '1', 02:53:26 INFO - 'PAGER': '/bin/cat', 02:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:26 INFO - 'PWD': '/builds/slave/test', 02:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:26 INFO - 'SHELL': '/bin/bash', 02:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:53:26 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:26 INFO - 'USER': 'cltbld', 02:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:26 INFO - 'XPC_FLAGS': '0x0', 02:53:26 INFO - 'XPC_SERVICE_NAME': '0', 02:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:26 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-VNxdSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:26 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-VllHjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:26 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-5ijTXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:26 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-tNCQdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:27 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Dr0vV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:27 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Xi4W4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:27 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-P943za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:27 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-cCz6lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:27 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-jIMjAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:27 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-nztkA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:27 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-EJW6fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:27 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-RWd832-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:27 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-EKiufg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:28 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-WWydCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:28 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-YkxxFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:28 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-ClE7m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:28 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-z4nrjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:53:28 INFO - Running setup.py install for manifestparser 02:53:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:53:28 INFO - Running setup.py install for mozcrash 02:53:28 INFO - Running setup.py install for mozdebug 02:53:28 INFO - Running setup.py install for mozdevice 02:53:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:53:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:53:29 INFO - Running setup.py install for mozfile 02:53:29 INFO - Running setup.py install for mozhttpd 02:53:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:53:29 INFO - Running setup.py install for mozinfo 02:53:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:53:29 INFO - Running setup.py install for mozInstall 02:53:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:53:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:53:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:53:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:53:29 INFO - Running setup.py install for mozleak 02:53:29 INFO - Running setup.py install for mozlog 02:53:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:53:29 INFO - Running setup.py install for moznetwork 02:53:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:53:30 INFO - Running setup.py install for mozprocess 02:53:30 INFO - Running setup.py install for mozprofile 02:53:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:53:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:53:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:53:30 INFO - Running setup.py install for mozrunner 02:53:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:53:30 INFO - Running setup.py install for mozscreenshot 02:53:30 INFO - Running setup.py install for moztest 02:53:30 INFO - Running setup.py install for mozversion 02:53:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:53:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:53:30 INFO - Cleaning up... 02:53:31 INFO - Return code: 0 02:53:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:31 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')]} 02:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:31 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')]} 02:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:31 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 0x105e32490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105da8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cf2c52380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, '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.1hxZ557g4s/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.ShKMfzNYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:53:31 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 02:53:31 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 02:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:31 INFO - 'HOME': '/Users/cltbld', 02:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:31 INFO - 'LOGNAME': 'cltbld', 02:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:31 INFO - 'MOZ_NO_REMOTE': '1', 02:53:31 INFO - 'NO_EM_RESTART': '1', 02:53:31 INFO - 'PAGER': '/bin/cat', 02:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:31 INFO - 'PWD': '/builds/slave/test', 02:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:31 INFO - 'SHELL': '/bin/bash', 02:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:53:31 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:31 INFO - 'USER': 'cltbld', 02:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:31 INFO - 'XPC_FLAGS': '0x0', 02:53:31 INFO - 'XPC_SERVICE_NAME': '0', 02:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-17H6e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:31 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)) 02:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-6nXazA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-5lnhMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:31 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)) 02:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-i7J7OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:31 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)) 02:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-JlyvoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:31 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)) 02:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-DdoXPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:31 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)) 02:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-vLJVJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:32 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)) 02:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-9h99_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:32 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)) 02:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-DGP0KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:32 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)) 02:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-ZvifhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:32 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)) 02:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-_6pmiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:32 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)) 02:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Vj2EIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:32 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)) 02:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-bnAjdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:32 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)) 02:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-sz8XiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-AleuSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:32 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)) 02:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-VhHdsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-6WSprw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:33 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)) 02:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:33 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)) 02:53:33 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)) 02:53:33 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)) 02:53:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53: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 02:53: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 02:53: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 02:53: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 02:53: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 02:53: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 02:53:35 INFO - Downloading blessings-1.6.tar.gz 02:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:53:35 INFO - Installing collected packages: blessings 02:53:35 INFO - Running setup.py install for blessings 02:53:36 INFO - Successfully installed blessings 02:53:36 INFO - Cleaning up... 02:53:36 INFO - Return code: 0 02:53:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:53:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:36 INFO - Reading from file tmpfile_stdout 02:53:36 INFO - Current package versions: 02:53:36 INFO - blessings == 1.6 02:53:36 INFO - blobuploader == 1.2.4 02:53:36 INFO - docopt == 0.6.1 02:53:36 INFO - functools32 == 3.2.3-2 02:53:36 INFO - jsonschema == 2.5.1 02:53:36 INFO - manifestparser == 1.1 02:53:36 INFO - mozInstall == 1.12 02:53:36 INFO - mozcrash == 1.0 02:53:36 INFO - mozdebug == 0.1 02:53:36 INFO - mozdevice == 0.48 02:53:36 INFO - mozfile == 1.2 02:53:36 INFO - mozhttpd == 0.7 02:53:36 INFO - mozinfo == 0.9 02:53:36 INFO - mozleak == 0.1 02:53:36 INFO - mozlog == 3.4 02:53:36 INFO - moznetwork == 0.27 02:53:36 INFO - mozprocess == 0.23 02:53:36 INFO - mozprofile == 0.28 02:53:36 INFO - mozrunner == 6.13 02:53:36 INFO - mozscreenshot == 0.1 02:53:36 INFO - mozsystemmonitor == 0.3 02:53:36 INFO - moztest == 0.8 02:53:36 INFO - mozversion == 1.4 02:53:36 INFO - psutil == 3.1.1 02:53:36 INFO - requests == 1.2.3 02:53:36 INFO - wsgiref == 0.1.2 02:53:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:37 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 0x105e32490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105da8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cf2c52380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, '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.1hxZ557g4s/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.ShKMfzNYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:53:37 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 02:53:37 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 02:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:37 INFO - 'HOME': '/Users/cltbld', 02:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:37 INFO - 'LOGNAME': 'cltbld', 02:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:37 INFO - 'MOZ_NO_REMOTE': '1', 02:53:37 INFO - 'NO_EM_RESTART': '1', 02:53:37 INFO - 'PAGER': '/bin/cat', 02:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:37 INFO - 'PWD': '/builds/slave/test', 02:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:37 INFO - 'SHELL': '/bin/bash', 02:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:53:37 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:37 INFO - 'USER': 'cltbld', 02:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:37 INFO - 'XPC_FLAGS': '0x0', 02:53:37 INFO - 'XPC_SERVICE_NAME': '0', 02:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:37 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)) 02:53:37 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)) 02:53:37 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)) 02:53:37 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)) 02:53:37 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)) 02:53:37 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)) 02:53:37 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)) 02:53:37 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)) 02:53:37 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)) 02:53:37 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)) 02:53:37 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)) 02:53:37 INFO - Cleaning up... 02:53:37 INFO - Return code: 0 02:53:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:53:37 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')]} 02:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:37 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')]} 02:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:37 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 0x105e32490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105da8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cf2c52380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, '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.1hxZ557g4s/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.ShKMfzNYRH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 02:53:37 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 02:53:37 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 02:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:37 INFO - 'HOME': '/Users/cltbld', 02:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:37 INFO - 'LOGNAME': 'cltbld', 02:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:37 INFO - 'MOZ_NO_REMOTE': '1', 02:53:37 INFO - 'NO_EM_RESTART': '1', 02:53:37 INFO - 'PAGER': '/bin/cat', 02:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:37 INFO - 'PWD': '/builds/slave/test', 02:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:37 INFO - 'SHELL': '/bin/bash', 02:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:53:37 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:37 INFO - 'USER': 'cltbld', 02:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:37 INFO - 'XPC_FLAGS': '0x0', 02:53:37 INFO - 'XPC_SERVICE_NAME': '0', 02:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:53:38 INFO - Cleaning up... 02:53:38 INFO - Return code: 0 02:53:38 INFO - Running post-action listener: _resource_record_post_action 02:53:38 INFO - Running post-action listener: _start_resource_monitoring 02:53:38 INFO - Starting resource monitoring. 02:53:38 INFO - [mozharness: 2017-01-20 10:53:38.131154Z] Finished create-virtualenv step (success) 02:53:38 INFO - [mozharness: 2017-01-20 10:53:38.132059Z] Running install step. 02:53:38 INFO - Running pre-action listener: _resource_record_pre_action 02:53:38 INFO - Running main action method: install 02:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:38 INFO - Reading from file tmpfile_stdout 02:53:38 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:38 INFO - Reading from file tmpfile_stdout 02:53:38 INFO - Output received: 02:53:38 INFO - Usage: mozinstall [options] installer 02:53:38 INFO - Options: 02:53:38 INFO - -h, --help show this help message and exit 02:53:38 INFO - -d DEST, --destination=DEST 02:53:38 INFO - Directory to install application into. [default: 02:53:38 INFO - "/builds/slave/test"] 02:53:38 INFO - --app=APP Application being installed. [default: firefox] 02:53:38 INFO - mkdir: /builds/slave/test/build/application 02:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:54:10 INFO - Reading from file tmpfile_stdout 02:54:10 INFO - Output received: 02:54:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:54:10 INFO - Running post-action listener: _resource_record_post_action 02:54:10 INFO - [mozharness: 2017-01-20 10:54:10.413886Z] Finished install step (success) 02:54:10 INFO - [mozharness: 2017-01-20 10:54:10.414017Z] Running run-tests step. 02:54:10 INFO - Running pre-action listener: _resource_record_pre_action 02:54:10 INFO - Running main action method: run_tests 02:54:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:54:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:54:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:54:10 INFO - 2017-01-20 02:54:10.428 screenresolution[1618:7540] starting screenresolution argv=screenresolution get 02:54:10 INFO - 2017-01-20 02:54:10.431 screenresolution[1618:7540] Display 0: 1600x1200x32@60 02:54:10 INFO - 2017-01-20 02:54:10.436 screenresolution[1619:7542] starting screenresolution argv=screenresolution list 02:54:10 INFO - Available Modes on Display 0 02:54:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:54:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:54:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:54:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:54:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:54:10 INFO - Intel Iris: 02:54:10 INFO - Chipset Model: Intel Iris 02:54:10 INFO - Type: GPU 02:54:10 INFO - Bus: Built-In 02:54:10 INFO - VRAM (Dynamic, Max): 1536 MB 02:54:10 INFO - Vendor: Intel (0x8086) 02:54:10 INFO - Device ID: 0x0a2e 02:54:10 INFO - Revision ID: 0x0009 02:54:10 INFO - Displays: 02:54:10 INFO - Display: 02:54:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:54:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:54:10 INFO - Display Serial Number: 1600x1200 60 02:54:10 INFO - Main Display: Yes 02:54:10 INFO - Mirror: Off 02:54:10 INFO - Online: Yes 02:54:10 INFO - Rotation: Supported 02:54:10 INFO - Return code: 0 02:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:54:10 INFO - Python 2.7.3 02:54:10 INFO - Return code: 0 02:54:10 INFO - grabbing minidump binary from tooltool 02:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:10 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 0x105c46d30>, '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 0x105aacdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c3eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:54:10 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 02:54:10 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 02:54:10 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 02:54:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:54:10 INFO - Return code: 0 02:54:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:54:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:54:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:54:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:54:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 02:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0155 --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 02:54:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1hxZ557g4s/Render', 02:54:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:10 INFO - 'HOME': '/Users/cltbld', 02:54:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:10 INFO - 'LOGNAME': 'cltbld', 02:54:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:54:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:10 INFO - 'MOZ_NO_REMOTE': '1', 02:54:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:54:10 INFO - 'NO_EM_RESTART': '1', 02:54:10 INFO - 'PAGER': '/bin/cat', 02:54:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:10 INFO - 'PWD': '/builds/slave/test', 02:54:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:54:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:10 INFO - 'SHELL': '/bin/bash', 02:54:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ShKMfzNYRH/Listeners', 02:54:10 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 02:54:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:10 INFO - 'USER': 'cltbld', 02:54:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:10 INFO - 'XPC_FLAGS': '0x0', 02:54:10 INFO - 'XPC_SERVICE_NAME': '0', 02:54:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 02:54:11 INFO - mozversion application_buildid: 20170120000424 02:54:11 INFO - mozversion application_changeset: b2e633d19d68a6777838d5730e3412d13de99474 02:54:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:54:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:54:11 INFO - mozversion application_name: Firefox 02:54:11 INFO - mozversion application_remotingname: firefox-dev 02:54:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:54:11 INFO - mozversion application_vendor: Mozilla 02:54:11 INFO - mozversion application_version: 52.0a2 02:54:11 INFO - mozversion platform_buildid: 20170120000424 02:54:11 INFO - mozversion platform_changeset: b2e633d19d68a6777838d5730e3412d13de99474 02:54:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:54:11 INFO - mozversion platform_version: 52.0a2 02:54:11 INFO - using testdate: 1484909651 02:54:11 INFO - actual date: 1484909651 02:54:11 INFO - starting webserver on 'localhost:49237' 02:54:11 INFO - SUITE-START | Running 2 tests 02:54:11 INFO - TEST-START | dromaeo_css 02:54:11 INFO - operating with platform_type : mac_ 02:54:11 INFO - Initialising browser for dromaeo_css test... 02:54:11 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmp1oddMc/profile http://localhost:49237/getInfo.html) 02:54:13 INFO - PROCESS | 1629 | __metrics Screen width/height:1600/1200 02:54:13 INFO - PROCESS | 1629 | colorDepth:24 02:54:13 INFO - PROCESS | 1629 | Browser inner width/height: 1024/689 02:54:13 INFO - PROCESS | 1629 | __metrics 02:54:13 INFO - PROCESS | 1629 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:54:13 INFO - PROCESS | 1629 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:54:14 INFO - TEST-INFO | 1629: exit 0 02:54:14 INFO - Browser initialized. 02:54:14 INFO - Running cycle 1/1 for dromaeo_css test... 02:54:14 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmp1oddMc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:27 INFO - PROCESS | 1631 | RSS: Main: 221798400 02:54:27 INFO - PROCESS | 1631 | 02:57:30 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 02:57:32 INFO - PROCESS | 1631 | RSS: Main: 369856512 02:57:32 INFO - PROCESS | 1631 | 03:00:35 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 03:00:35 INFO - PROCESS | 1631 | RSS: Main: 351760384 03:00:35 INFO - PROCESS | 1631 | 03:03:38 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 03:03:38 INFO - PROCESS | 1631 | RSS: Main: 310202368 03:03:38 INFO - PROCESS | 1631 | 03:06:41 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 03:06:41 INFO - PROCESS | 1631 | RSS: Main: 324542464 03:06:41 INFO - PROCESS | 1631 | 03:09:45 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 03:09:45 INFO - PROCESS | 1631 | RSS: Main: 307593216 03:09:45 INFO - PROCESS | 1631 | 03:12:48 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 03:12:49 INFO - PROCESS | 1631 | RSS: Main: 481427456 03:12:49 INFO - PROCESS | 1631 | 03:12:49 INFO - PROCESS | 1631 | __start_tp_report 03:12:49 INFO - PROCESS | 1631 | _x_x_mozilla_page_load 03:12:49 INFO - PROCESS | 1631 | _x_x_mozilla_page_load_details 03:12:49 INFO - PROCESS | 1631 | |i|pagename|runs| 03:12:49 INFO - PROCESS | 1631 | |0;dojo.html;3187.6174859016924;3336.866525338987;3343.8328083595816;3354.8825791097315;3415.538902248196;4433.512313645497;5156.407013193484;5727.255456790612;5733.913991290134;5757.683327416996;5650.434956504358;5753.948495289687;5762.135679648044;5777.335606405265;5821.912671309923;5186.170212765949;5201.219817027439;5219.138842091051;5235.947640523584;5274.208868669711;5117.257997590347;5119.56483698886;5121.436641969381;5147.845564633067;5359.062164121283;5287.894242115175;5293.020791153649;5300.946990530084;5318.0161670090965;5346.4118946916005;5284.762185701634;5294.841154765363;5305.602079843989;5311.5750739941095;5318.1225097859;5096.719680417576;5170.663906846043;5242.370915490127;5243.816466423695;5275.314209152785;5615.887682246373;5626.043572592669;5675.829725108253;5691.430856914317;5745.1382292656435;6165.383461653799;6214.65819379934;6249.375162457748;6257.311695713468;6289.811305660792;6250.718717657716;6263.812085637393;6295.024271237966;6295.338989406092;6309.179806625109;4374.650027997753;5606.831795046155;5722.799702010493;5811.738471768781;5853.180554722342;6208.1308616793685;6242.500599951993;6245.750169993149;6257.56197066201;6268.122462855204;5992.790252341147;6158.476529494954;6193.566450348522;6199.690015499207;6202;5494.148406996922;6047.727852246571;6096.786612468631;6100.816975490742;6188.44304012641;6190.969045154746;6253.7185826637915;6262.624242545462;6278.372162783685;6285.371462853678;6144.846378840565;6266.937330626726;6267.905981410283;6273.592216505913;6292.937070629327;4788.257820037899;4967.701937883667;4972.776225069881;4978.65149439543;4985.376827896513;4275.29457639486;4367.30123180296;4382.978085109554;4386.122775444924;4395.296752519582;5796.42035796417;5805.042168042226;5813.767449302065;5828.679422631796;5854.034084376115;6191.380861913773;6252.062190671436;6258.061290806416;6269.310375858743;6296.937030629727;5688;5694.345150307685;5711.857203569861;5759.625624334405;5764.567657425626;5362.142057270896;5362.65142765719;5393.029254734107;5408.702521361363;5438.265834112344;5375.59683023767;6228.47058000066;6319.178506794179;6330.240371155491;6346.682665866781;4679.836205732783;6117.766507567455;6148.938510614837;6229.844253893508;6248.625082495065;6173.382661733791;6198.938010619836;6207.255129384503;6269.435750782452;6285.622862628257;6141.048137538689;6187.84530386744;6195.96902015487;6216.844578885564;6236.6258024518675;6211.782587609412;6252;6272.18461599989;6278.497720182283;6291.937080629318;6001.3998600141385;6059.484943779828;6066.1507388966465;6069.817905462844;6116.26604807426;6118.223266370627;6118.776841100606;6127.892078906909;6136.5090792737365;6143.174139895698;5945.494632956074;5966.671833049224;6017.548683848817;6027.668478233739;6041.335453100243;5888.646681199141;5924.703764811656;5927.555433342431;5976.372480889444;6139.478144357601;5714.257146570919;5775.306963164448;5808.854778630568;5812.9709351452975;5822.505087067647 03:12:49 INFO - PROCESS | 1631 | |1;ext.html;508.8804131029208;517.1751057063982;522.4096770649165;525.4850246758177;550.7714298566095;29851;39548;40554.78335649935;40728.185436291256;42404.57595424045;41711.791441042755;42071;42187.57812421875;42193.57806421942;42336.78831605845;9260.953695231532;9411.105944935254;9417.340786144938;9428.198603118743;9430.29272804539;9279.21126704231;9378.624855005792;9382.671606493774;9393.107654772819;9447.149756521912;8036.758897233063;9307;9343.43939363637;9368;9382.437053776795;9340.486273254968;9371.34400591959;9380.90619093814;9384.765380865465;9402.012788657195;9147.54262286883;9232.30757693169;9237.769055773591;9241.861372079424;9248.676296329664;39531.80234098811;39934.400983985266;39936.400953985714;39939.80030099831;40027.79986100051;3261.4618587932964;3344.3812894614575;3410.0792785947656;3458.1354661334667;3607.92730488527;28594.571081433794;29513.704862951312;29779.49556513544;30121.849390753126;31611.683883161106;3155.984220078908;3195.121341631047;3205.294835136266;3206.5671134397026;3239.82180980046;414698;486067;496552;497182;499063.9999999964;64182;65455;65489.67255163789;65561.01658475031;65573.34426655673;28945.85527072351;36162.8191859039;36557.45163822545;69242.30757692459;69688;15893.046417215004;16245.675086498204;16259;16276.10481423533;16276.918615407085;12325.568605098779;12427.44076516559;12431.067669924792;12441.93779031099;12476.313802740937;19699.916504592384;19710;20005.399838004883;20437.978101094886;20444.0578145076;8089.555074470843;8107.959460202661;8225.424220304641;8259.587020648944;8304.626291816883;826.5206180415345;911.0297533127198;944.7590864329552;954.7040417470606;1076.1390887290293;28704.856475717486;29310.85344573306;29642.851785741364;30059.549106763418;30446;1069.6416700405296;1073.6510634043966;1077.719792853848;1109.9334039957466;1131.4060118437721;13185.934070329587;15233.542993710207;15438.5368438947;15552.455664051704;15751.887777794445;704364;713753.4312328509;715421;715559;718063;57598.42401575931;58470;60835.39164608297;60948.39051609516;61004.779904401665;1373.6085215713674;1391.0818859552646;1414.7099844532052;1417.333853089026;1418.0569921002418;29742.10773676793;30691.386172275983;31111.84444077765;31165.220869478446;31718.841405792824;51503.484965149866;52012.21981670354;52053;52080.73959630178;52094;600036;603008.9849550724;603758;603902;604978;42006.789966049975;42388.78805605952;43095;43144.78427607842;43163;46527.76736116298;46558.53441465677;46764.7661761689;47075;47515.57453276407;32385.35229295448;35262;38321.61678383292;38933.22133557256;40405.59594404136;38420.42369364518;38514.422283666325;38634.8409547714;38983.22033559256;38989;36474.635253648186;37964.2407151861;38579;38726.03184920287;40127.799361004174;31463;34506.309873802886;34546.480674048755;35088.64911350956;35179.47230791489;20370;25676.743232567434;25691.614625781003;25901.6114758275;26716.465670686866 03:12:49 INFO - PROCESS | 1631 | |2;jquery.html;347.3019231344996;370.3722190886448;374.1674773628675;380.4426515155298;399.55649229355413;12779.680507987294;14555.927220363896;14918.477853275137;19462.221511139538;19991.700124498144;18930.810691893075;19413.805861941375;19928.50178745532;20050.699239511418;20480.590388192228;5793.478586927165;6105.023196288595;6115.755369785204;6121.755129794803;6130.478909292693;4768.950830817214;5936.050231962887;5991.610545314541;6007.609505382136;6009.1587177795145;5634.183043458696;5941.316748573926;5947;5948.672822994755;5960.582759206857;5340.092184328634;5664.971675141598;5876.9118463223085;5962.463378295931;5966.134910437984;5005.499450054966;5212;5216.7913283468615;5222.399424066243;5301.0723123453245;13035;13066.954643628487;13191.538296159684;13301.667458313523;13349.933250333783;1939.486036200394;2179.7711240319854;2276.7950884420484;2288.988555057214;2308.6306191009526;9923.454210018446;10432.165426765916;10523.631672891412;12427.627171184879;14456.638584035378;1812.151843430087;1841.9815801841944;1854.0729635182408;1890.8203720646516;1920.9807901920942;104910;115374.65439400829;120383;123277.38361308226;126697;9409.435433873989;9739.707808765748;9897.950510247403;10103.949480252551;10247;11998;12373.75252494945;12395.566155184526;12432.813507797391;12491.812622810665;7751.844963100706;8000.039995200613;8010.959945200237;8072.596370181467;8092.959535202404;8210.425270231026;8225.71210007647;8233;8355.958220208982;8385.454945428528;3285.671432856743;3893.8831835044994;3894.1043559981363;3987.063040185554;3992.3612222044335;1870.887746735173;1907.8282954533881;1921.2987259650406;1922.5097600112163;1930.7972662870477;650.4601181019742;697.5704277835703;711.8860982242817;822.0687737970571;872.7774417523618;19906.701399479018;21168.941552922293;21366.465838353855;21448.892755536122;21468;891.8573028315568;899.8965119011398;902.4630344944748;907.2197909797569;915.9633614655472;10736.838947415796;10775.976282253174;11188.888111118948;11287.887121128848;11337.773244535063;539891;543355;559748;578941;581439;94452;118842;119950.40024799995;120305.39847300883;123243.38378308051;808.7129069180356;906.1482206725657;928.679605536089;943.1558754914313;946.5503885654397;18459.169337379582;19219;19556.511087222934;19583.412497625093;19589.80410195937;39879.80060099681;40281;51666.225006624176;52076.739616301675;53119.20321195108;53783.46216537941;73091.63454182695;74293.25706742864;79105.60447197728;81444;7949.92050079515;8074.1522140176785;8188;8293.21214484623;8310.792230194293;11985.64043078709;12216.633500994983;12264.202826816228;12816.6795830105;12896.935515322364;11348.092152627934;11357.886421135683;11426.428678566204;11859.466324015613;11903.047756179658;9879.20966322678;10386.013328733758;11090.611828585961;11093.722656933642;11429.771404571695;11508.654740357802;11856.992155666865;11906.40467976615;11950.880491195325;12049.939750301193;8017.8797318039105;8322.62548185321;8395.832083358177;8401.495910245405;8421.410501264852;8146.266835984789;8606.741797746077;10802.945985270338;11084.946930041633;11242.66272011841 03:12:49 INFO - PROCESS | 1631 | |3;mootools.html;1383.4327925550524;1442.1995792335254;1589.8807589430796;1798.1009495252374;1823.6170404215122;8033.799155021127;8408.873866892001;8432.494050356976;8463.619137138829;8477.237048665618;7291.562506249628;7597;7601.923980760191;8045.839083218332;8299.543525106117;2250.2349201271522;2286.6112760830697;2289.1530133850497;2289.919852805152;2290.9656355154684;2283.56612243674;2314.0628045641542;2332.918347857825;2335.836491445591;2337;2313.595120853852;2314.4908120213527;2330.4872927955907;2333.708286464192;2338.53229354129;2028.3407892435018;2072.98963505183;2091.435312465626;2292.106078629336;2318.119114736406;2322.6632138339846;2343.7070366204225;2345.777151170636;2347.5891718949288;2350.4593943393115;8191;8376.329893608558;8383.203595658464;8384.664613415456;8395.790105247357;4981.750912454399;5134.306868572732;5138.075146473633;5138.10083235436;5145.871353216162;3262.5106234064842;3323.6510166432417;3568.518250036238;3572.732045096602;3584.5698516178227;964.6623681711415;1037.4397825174397;1057.9682609521726;1095.2497539185683;1104.4588151805638;10737.302075365154;10859.891401086046;10926.344419334866;11006.174536909684;11048.447577621087;4477;4571.634269258451;4656.511066338054;4663.650226233046;4734.171519983989;9438.575264112995;9443.150116489549;9444.338896277332;9463.148316651534;9463.90536094644;5050.6464547482055;5137.460566640524;5162.6902385856965;5174.7153906535505;5187.792488300426;4217.7891105444605;4332.610065094157;4554;4602.240630296031;4693.7653117344;3301.3892429900066;3780.3762379207124;3781;3858.864939727096;3886.7473614214987;1217.11150859871;1217.6225370135287;1221.2977537915733;1227.0674287541533;1227.1348699167065;798.6126728536655;861.4917198852708;894.9373543851998;898.6944438890808;911.7082533589188;5607.80372686954;5691.317041954909;5806.88386232273;5814.30228372598;5887.676177810262;832.6710949175042;908.3777612335439;910.6311943662827;923.5566927874657;940.0740270833223;3677;3727.0682329417646;3757.267332870119;3807.4098514730263;3847.788371639531;9854.310198286195;10234.130098941674;10251.179905607683;10276.22928280367;10282.537285822156;9908.455034973002;9974;10216.438095904648;10221.080102790784;10236.53935572901;7741.651625676858;7846.3330616897065;7872.134065252818;7878.487898286708;7901.644426000844;5312.150055991023;5429.592780541554;5511.696856672921;5649.858753531194;5680.829575112753;7732.342750866239;9263.16631503168;9411.623535058794;9444.386114902509;9471.147596716328;7860.6069696513805;9073.230720009535;9418.529073546159;9440.575174117319;9490.430574165572;6557.540972131905;6773.89839152423;6783.18601767791;7185.886187640924;7358.190599034209;7405.518641288299;7492.1384040836;7500.212477689764;7542.434317426105;7682.385409167141;5748.913766293593;7184.209736928829;7229.783106506813;7231.891521627074;7323.414126869731;7043.929560704328;7082.858342833218;7109.644517773987;7114.750983715545;7173.856522869618;5634.464725851038;6527.771527996498;6566.310537393505;6645.833854153685;6721.428678562377;4209.978950105352;4649.442066951988;4707.435107787088;4802.135615589227;4891.877703057452;4752.239641657318;4776.2119250324695;4848.490908454562;4894.975525122351;5030.924536131888 03:12:49 INFO - PROCESS | 1631 | |4;prototype.html;287.84600238872207;290.765933423594;302.164515115705;311.80667985848777;315.4023126175898;5195.922061169081;5270.446603106676;5286.959998001145;5301.6818990860575;5307.73461326934;4184.932842125261;4329.203380597049;4576.267797152448;4883;5031.748412579374;4013.819378127984;4049.311617025113;4062.3344428784203;4104.42538044674;4117.855875044374;3580.3888250287346;3847.576766555677;4070.9389359159636;4079.1637714268504;4099.028204551706;3291.6708329167013;3334.4664853623426;3907.0008315946156;3999.180168065554;4058.336082206296;4002.6584448097897;4005.319095753729;4005.619466150711;4026.0740029793164;4052.1909405159204;3493.283876805249;3495.3883070462566;3515.4023815951095;3528.576570811493;3531.593866705336;4774.734695305747;4815;5063.39235293824;5096.872578185538;5131.512506311894;4025.9733767889;4155.335146376596;4612.677112602119;4645.837395691135;4651.441647139941;4450.621697155746;4760.785764640599;4828.8893554482665;5472.26124473195;5504.724763761796;3251.7398608111293;3324.750643701732;3365.788316206164;3739.775613463201;3891.6886649068006;4836.210602077219;4848.884756506023;4989.401271847365;5385.434529374398;5739.426057394227;3332.233586275122;3917.6082391760597;3927.8821635350987;3943.8422463101156;3972.483577134954;3652.2695460907926;3714.88855334335;4020.798960051986;4029.3351596986754;4049.5545489996666;3573.4997100405963;4600.033992861537;4658.627309815207;4674.953250467452;4700.929486057712;4451.9554804451545;5537.36320323168;5542.418046105101;5543.722813859291;5571.832845014656;1241.3731065811708;1289.3939848271298;1301.9519286973887;1309.7838856588555;1311.4819646239682;778.373409405434;784.6429874407131;840.2899549880341;859.737779977113;895.7357579514058;3938.1139243669945;4368.6723495737315;4851.660383773102;4853.975730121398;4930.975345123252;4609.8847528811375;4815.109204797123;5008.474110218447;5213.488088454305;5316.787328506894;4552.975580494429;4570.674504393689;4609.838655647036;4810.470848206694;4873.342098816685;2247.4156719252783;2489.3776555861036;2589.52093862636;2632.328756167165;2832.8017038807084;4692.389989301369;5487.228949380537;5491.7254137292975;5534.229046705016;5578.41426650204;4645.9325600108305;4829.806807727651;5280.762365693553;5409.864753381118;5417.83746487606;4878.975605121952;5088.720120393414;5441.8095366662765;5448.6378405398655;5481.506664400223;5295.7352132394;5299.30422264887;5317.308749862493;5332.093544097435;5389.353277606556;4555.8177672894035;4807.302941073455;4914.950850491592;5251.868703282295;5252.789888404421;4427.358033085249;5396.5699089740465;5398.676079435247;5454.2003037326895;5454.463674391427;3228.773985821064;3298.5711857458377;3728.6084961078695;3757.7369584128846;3764.3600587899573;4883.706977581356;5169.586433085269;5335.546478549211;5344.759485823225;5385.75764090609;3956.723029387915;5009.448960614257;5118.769655365592;5165.070287348163;5215.348081489814;3985.6811455084103;4471.311168286112;4622.560856718606;4782.141876201626;4991.575716064175;4738.384010078806;4829.66192366531;4972.900541989212;5004.599632029356;5143.5627971622835;4575.3823233863;4889.828855990023;5359.517643412111;5368.597355198453;5534.806281780118;4744.88137796544;4772.5227477252;4778.737169455713;5460.535854452416;5466.125419932791 03:12:49 INFO - PROCESS | 1631 | |5;yui.html;695.1484431571323;696.52636207379;700.5796522086746;751.6692655231695;760.9353204977576;13813.96395270355;14175.574732758021;14181.503647372345;14183.149011059344;14185.290735463237;12649.62051138465;12957.157784743986;14177.291135443238;14726.558203253893;14732.0424172429;658.7562601837327;809.3323008517967;834.8664213725805;835.8799209059858;835.9331253499705;664.0802488553364;673.3199468536765;787.9724209652663;809.7732634862248;823.4359463767308;879.0594064351114;881.6517475597135;881.6561540999015;881.9029906710257;882.5631312500321;873.8470767615673;874.3617159473556;874.7463235661651;875.1991927386402;877.9771566125456;453.53059583331094;497.33958068614965;515.6493584362632;623.5198896849446;630.9432151106377;14251.002429829916;14275.643108922257;14293.070950388192;14297.14217146964;14301.213433261271;12316.829901159375;12343.691407714789;12586.307753073577;12793.232406055666;12812.039097067664;10531.631392901289;11981.460834262392;12100.576479823252;12134;12137;3551.982240088783;3580.4092324766384;3713.610070942539;4273.209456250573;4305.354196870463;77248.61375693142;78763.99999999943;80349;82768;82949.58525207396;7990.452036401634;8731.039585645574;9908;10161.646656603303;10186.949065254626;19636.312729054414;19657.901710491642;19672;19685.11416986239;19795.703064454046;7064;7107.609081500567;7453.552786832807;7491.400687944952;7497.2877576630135;3556.41319182332;4012.598740126022;4125.876223713293;4224.598663126998;4243.42713733642;3268.2156282492033;3326.7837590556537;3373.6120346160014;3391.1522119470133;3395.2360718838063;612.3325575123138;614.241411856357;622.4553515673786;622.4802290087828;628.3496581038694;548.6598309048416;565.0559097499477;623.7255607532762;625.7997440818986;672.085963090197;8649.524276164746;8717.782055448664;8771.342149338825;8970.443423624236;9175.58709858058;506.82261208576705;542.4169018305338;600.3486217454024;650.6291413894035;670.1823774994499;4093.836246550164;4310.353446982977;4319.784010799447;4320.395144679747;4420.646348292129;106082.46958765156;106395.46802266093;113868;114252;115407;87759;89026;93065.5346723262;93655.59516607257;97028;80948.7857682147;82078.35843283101;82317.58841205755;82983.5850820742;83337.3332533346;8392.87410688828;8550.91449085526;8596.269317107866;8691.304695624209;8773.824523509622;41576.79211603923;49142.75428622834;52951;56573.71713141408;56772.58068548319;77847.10764461868;78894;79512.84900611357;80324.59837700774;81541;10820.296680715728;10922.235443518877;10979.451027448755;10990.945045274722;11487.655370338904;11859.182751723501;11893.405329733305;11901.226420282654;11995.820062698893;12238.510459581517;10566.260361774603;11408.144389170679;11675.416229188337;11744.647660570197;12096.516139354328;11272.66182014541;11658.300501969909;11745.47145378443;12147.149699520949;12493.625191244277;12155.02759779198;12158;12396.624178103206;12490.313032783284;13083.803742943674;8235.752927412188;9969.950150249202;10367.066963972977;10769.838452423377;11044.889551104387;6930.341617546325;8967.237784788365;10019.749506262402;10505.789884202426;10545.209109316678 03:12:49 INFO - PROCESS | 1631 | __end_tp_report 03:12:49 INFO - PROCESS | 1631 | __start_cc_report 03:12:49 INFO - PROCESS | 1631 | _x_x_mozilla_cycle_collect,1734 03:12:49 INFO - PROCESS | 1631 | __end_cc_report 03:12:49 INFO - PROCESS | 1631 | __startTimestamp1484910769202__endTimestamp 03:12:49 INFO - PROCESS | 1631 | 03:12:49 INFO - PROCESS | 1631 | ------- Summary: start ------- 03:12:49 INFO - PROCESS | 1631 | Number of tests: 6 03:12:49 INFO - PROCESS | 1631 | 03:12:49 INFO - PROCESS | 1631 | [#0] dojo.html Cycles:165 Average:5706.99 Median:5854.03 stddev:658.01 (11.2%) stddev-sans-first:629.65 03:12:49 INFO - PROCESS | 1631 | Values: 3187.6 3336.9 3343.8 3354.9 3415.5 4433.5 5156.4 5727.3 5733.9 5757.7 5650.4 5753.9 5762.1 5777.3 5821.9 5186.2 5201.2 5219.1 5235.9 5274.2 5117.3 5119.6 5121.4 5147.8 5359.1 5287.9 5293.0 5300.9 5318.0 5346.4 5284.8 5294.8 5305.6 5311.6 5318.1 5096.7 5170.7 5242.4 5243.8 5275.3 5615.9 5626.0 5675.8 5691.4 5745.1 6165.4 6214.7 6249.4 6257.3 6289.8 6250.7 6263.8 6295.0 6295.3 6309.2 4374.7 5606.8 5722.8 5811.7 5853.2 6208.1 6242.5 6245.8 6257.6 6268.1 5992.8 6158.5 6193.6 6199.7 6202.0 5494.1 6047.7 6096.8 6100.8 6188.4 6191.0 6253.7 6262.6 6278.4 6285.4 6144.8 6266.9 6267.9 6273.6 6292.9 4788.3 4967.7 4972.8 4978.7 4985.4 4275.3 4367.3 4383.0 4386.1 4395.3 5796.4 5805.0 5813.8 5828.7 5854.0 6191.4 6252.1 6258.1 6269.3 6296.9 5688.0 5694.3 5711.9 5759.6 5764.6 5362.1 5362.7 5393.0 5408.7 5438.3 5375.6 6228.5 6319.2 6330.2 6346.7 4679.8 6117.8 6148.9 6229.8 6248.6 6173.4 6198.9 6207.3 6269.4 6285.6 6141.0 6187.8 6196.0 6216.8 6236.6 6211.8 6252.0 6272.2 6278.5 6291.9 6001.4 6059.5 6066.2 6069.8 6116.3 6118.2 6118.8 6127.9 6136.5 6143.2 5945.5 5966.7 6017.5 6027.7 6041.3 5888.6 5924.7 5927.6 5976.4 6139.5 5714.3 5775.3 5808.9 5813.0 5822.5 03:12:49 INFO - PROCESS | 1631 | 03:12:49 INFO - PROCESS | 1631 | [#1] ext.html Cycles:180 Average:72865.51 Median:40480.19 stddev:162415.74 (401.2%) stddev-sans-first:162780.50 03:12:49 INFO - PROCESS | 1631 | Values: 508.9 517.2 522.4 525.5 550.8 29851.0 39548.0 40554.8 40728.2 42404.6 41711.8 42071.0 42187.6 42193.6 42336.8 9261.0 9411.1 9417.3 9428.2 9430.3 9279.2 9378.6 9382.7 9393.1 9447.1 8036.8 9307.0 9343.4 9368.0 9382.4 9340.5 9371.3 9380.9 9384.8 9402.0 9147.5 9232.3 9237.8 9241.9 9248.7 39531.8 39934.4 39936.4 39939.8 40027.8 3261.5 3344.4 3410.1 3458.1 3607.9 28594.6 29513.7 29779.5 30121.8 31611.7 3156.0 3195.1 3205.3 3206.6 3239.8 414698.0 486067.0 496552.0 497182.0 499064.0 64182.0 65455.0 65489.7 65561.0 65573.3 28945.9 36162.8 36557.5 69242.3 69688.0 15893.0 16245.7 16259.0 16276.1 16276.9 12325.6 12427.4 12431.1 12441.9 12476.3 19699.9 19710.0 20005.4 20438.0 20444.1 8089.6 8108.0 8225.4 8259.6 8304.6 826.5 911.0 944.8 954.7 1076.1 28704.9 29310.9 29642.9 30059.5 30446.0 1069.6 1073.7 1077.7 1109.9 1131.4 13185.9 15233.5 15438.5 15552.5 15751.9 704364.0 713753.4 715421.0 715559.0 718063.0 57598.4 58470.0 60835.4 60948.4 61004.8 1373.6 1391.1 1414.7 1417.3 1418.1 29742.1 30691.4 31111.8 31165.2 31718.8 51503.5 52012.2 52053.0 52080.7 52094.0 600036.0 603009.0 603758.0 603902.0 604978.0 42006.8 42388.8 43095.0 43144.8 43163.0 46527.8 46558.5 46764.8 47075.0 47515.6 32385.4 35262.0 38321.6 38933.2 40405.6 38420.4 38514.4 38634.8 38983.2 38989.0 36474.6 37964.2 38579.0 38726.0 40127.8 31463.0 34506.3 34546.5 35088.6 35179.5 20370.0 25676.7 25691.6 25901.6 26716.5 03:12:49 INFO - PROCESS | 1631 | 03:12:49 INFO - PROCESS | 1631 | [#2] jquery.html Cycles:180 Average:32753.10 Median:377.31 stddev:93706.03 (24835.6%) stddev-sans-first:93937.31 03:12:49 INFO - PROCESS | 1631 | Values: 347.3 370.4 374.2 380.4 399.6 12779.7 14555.9 14918.5 19462.2 19991.7 18930.8 19413.8 19928.5 20050.7 20480.6 5793.5 6105.0 6115.8 6121.8 6130.5 4769.0 5936.1 5991.6 6007.6 6009.2 5634.2 5941.3 5947.0 5948.7 5960.6 5340.1 5665.0 5876.9 5962.5 5966.1 5005.5 5212.0 5216.8 5222.4 5301.1 13035.0 13067.0 13191.5 13301.7 13349.9 1939.5 2179.8 2276.8 2289.0 2308.6 9923.5 10432.2 10523.6 12427.6 14456.6 1812.2 1842.0 1854.1 1890.8 1921.0 104910.0 115374.7 120383.0 123277.4 126697.0 9409.4 9739.7 9898.0 10103.9 10247.0 11998.0 12373.8 12395.6 12432.8 12491.8 7751.8 8000.0 8011.0 8072.6 8093.0 8210.4 8225.7 8233.0 8356.0 8385.5 3285.7 3893.9 3894.1 3987.1 3992.4 1870.9 1907.8 1921.3 1922.5 1930.8 650.5 697.6 711.9 822.1 872.8 19906.7 21168.9 21366.5 21448.9 21468.0 891.9 899.9 902.5 907.2 916.0 10736.8 10776.0 11188.9 11287.9 11337.8 539891.0 543355.0 559748.0 578941.0 581439.0 94452.0 118842.0 119950.4 120305.4 123243.4 808.7 906.1 928.7 943.2 946.6 18459.2 19219.0 19556.5 19583.4 19589.8 39879.8 40281.0 51666.2 52076.7 53119.2 53783.5 73091.6 74293.3 79105.6 81444.0 7949.9 8074.2 8188.0 8293.2 8310.8 11985.6 12216.6 12264.2 12816.7 12896.9 11348.1 11357.9 11426.4 11859.5 11903.0 9879.2 10386.0 11090.6 11093.7 11429.8 11508.7 11857.0 11906.4 11950.9 12049.9 8017.9 8322.6 8395.8 8401.5 8421.4 8146.3 8606.7 10802.9 11084.9 11242.7 03:12:49 INFO - PROCESS | 1631 | 03:12:49 INFO - PROCESS | 1631 | [#3] mootools.html Cycles:180 Average:5394.59 Median:5138.09 stddev:2964.67 (57.7%) stddev-sans-first:2957.66 03:12:49 INFO - PROCESS | 1631 | Values: 1383.4 1442.2 1589.9 1798.1 1823.6 8033.8 8408.9 8432.5 8463.6 8477.2 7291.6 7597.0 7601.9 8045.8 8299.5 2250.2 2286.6 2289.2 2289.9 2291.0 2283.6 2314.1 2332.9 2335.8 2337.0 2313.6 2314.5 2330.5 2333.7 2338.5 2028.3 2073.0 2091.4 2292.1 2318.1 2322.7 2343.7 2345.8 2347.6 2350.5 8191.0 8376.3 8383.2 8384.7 8395.8 4981.8 5134.3 5138.1 5138.1 5145.9 3262.5 3323.7 3568.5 3572.7 3584.6 964.7 1037.4 1058.0 1095.2 1104.5 10737.3 10859.9 10926.3 11006.2 11048.4 4477.0 4571.6 4656.5 4663.7 4734.2 9438.6 9443.2 9444.3 9463.1 9463.9 5050.6 5137.5 5162.7 5174.7 5187.8 4217.8 4332.6 4554.0 4602.2 4693.8 3301.4 3780.4 3781.0 3858.9 3886.7 1217.1 1217.6 1221.3 1227.1 1227.1 798.6 861.5 894.9 898.7 911.7 5607.8 5691.3 5806.9 5814.3 5887.7 832.7 908.4 910.6 923.6 940.1 3677.0 3727.1 3757.3 3807.4 3847.8 9854.3 10234.1 10251.2 10276.2 10282.5 9908.5 9974.0 10216.4 10221.1 10236.5 7741.7 7846.3 7872.1 7878.5 7901.6 5312.2 5429.6 5511.7 5649.9 5680.8 7732.3 9263.2 9411.6 9444.4 9471.1 7860.6 9073.2 9418.5 9440.6 9490.4 6557.5 6773.9 6783.2 7185.9 7358.2 7405.5 7492.1 7500.2 7542.4 7682.4 5748.9 7184.2 7229.8 7231.9 7323.4 7043.9 7082.9 7109.6 7114.8 7173.9 5634.5 6527.8 6566.3 6645.8 6721.4 4210.0 4649.4 4707.4 4802.1 4891.9 4752.2 4776.2 4848.5 4895.0 5030.9 03:12:49 INFO - PROCESS | 1631 | 03:12:49 INFO - PROCESS | 1631 | [#4] prototype.html Cycles:180 Average:4265.37 Median:4741.63 stddev:1273.49 (26.9%) stddev-sans-first:1241.57 03:12:49 INFO - PROCESS | 1631 | Values: 287.8 290.8 302.2 311.8 315.4 5195.9 5270.4 5287.0 5301.7 5307.7 4184.9 4329.2 4576.3 4883.0 5031.7 4013.8 4049.3 4062.3 4104.4 4117.9 3580.4 3847.6 4070.9 4079.2 4099.0 3291.7 3334.5 3907.0 3999.2 4058.3 4002.7 4005.3 4005.6 4026.1 4052.2 3493.3 3495.4 3515.4 3528.6 3531.6 4774.7 4815.0 5063.4 5096.9 5131.5 4026.0 4155.3 4612.7 4645.8 4651.4 4450.6 4760.8 4828.9 5472.3 5504.7 3251.7 3324.8 3365.8 3739.8 3891.7 4836.2 4848.9 4989.4 5385.4 5739.4 3332.2 3917.6 3927.9 3943.8 3972.5 3652.3 3714.9 4020.8 4029.3 4049.6 3573.5 4600.0 4658.6 4675.0 4700.9 4452.0 5537.4 5542.4 5543.7 5571.8 1241.4 1289.4 1302.0 1309.8 1311.5 778.4 784.6 840.3 859.7 895.7 3938.1 4368.7 4851.7 4854.0 4931.0 4609.9 4815.1 5008.5 5213.5 5316.8 4553.0 4570.7 4609.8 4810.5 4873.3 2247.4 2489.4 2589.5 2632.3 2832.8 4692.4 5487.2 5491.7 5534.2 5578.4 4645.9 4829.8 5280.8 5409.9 5417.8 4879.0 5088.7 5441.8 5448.6 5481.5 5295.7 5299.3 5317.3 5332.1 5389.4 4555.8 4807.3 4915.0 5251.9 5252.8 4427.4 5396.6 5398.7 5454.2 5454.5 3228.8 3298.6 3728.6 3757.7 3764.4 4883.7 5169.6 5335.5 5344.8 5385.8 3956.7 5009.4 5118.8 5165.1 5215.3 3985.7 4471.3 4622.6 4782.1 4991.6 4738.4 4829.7 4972.9 5004.6 5143.6 4575.4 4889.8 5359.5 5368.6 5534.8 4744.9 4772.5 4778.7 5460.5 5466.1 03:12:49 INFO - PROCESS | 1631 | 03:12:49 INFO - PROCESS | 1631 | [#5] yui.html Cycles:180 Average:19938.77 Median:24820.05 stddev:29597.08 (119.2%) stddev-sans-first:29644.84 03:12:49 INFO - PROCESS | 1631 | Values: 695.1 696.5 700.6 751.7 760.9 13814.0 14175.6 14181.5 14183.1 14185.3 12649.6 12957.2 14177.3 14726.6 14732.0 658.8 809.3 834.9 835.9 835.9 664.1 673.3 788.0 809.8 823.4 879.1 881.7 881.7 881.9 882.6 873.8 874.4 874.7 875.2 878.0 453.5 497.3 515.6 623.5 630.9 14251.0 14275.6 14293.1 14297.1 14301.2 12316.8 12343.7 12586.3 12793.2 12812.0 10531.6 11981.5 12100.6 12134.0 12137.0 3552.0 3580.4 3713.6 4273.2 4305.4 77248.6 78764.0 80349.0 82768.0 82949.6 7990.5 8731.0 9908.0 10161.6 10186.9 19636.3 19657.9 19672.0 19685.1 19795.7 7064.0 7107.6 7453.6 7491.4 7497.3 3556.4 4012.6 4125.9 4224.6 4243.4 3268.2 3326.8 3373.6 3391.2 3395.2 612.3 614.2 622.5 622.5 628.3 548.7 565.1 623.7 625.8 672.1 8649.5 8717.8 8771.3 8970.4 9175.6 506.8 542.4 600.3 650.6 670.2 4093.8 4310.4 4319.8 4320.4 4420.6 106082.5 106395.5 113868.0 114252.0 115407.0 87759.0 89026.0 93065.5 93655.6 97028.0 80948.8 82078.4 82317.6 82983.6 83337.3 8392.9 8550.9 8596.3 8691.3 8773.8 41576.8 49142.8 52951.0 56573.7 56772.6 77847.1 78894.0 79512.8 80324.6 81541.0 10820.3 10922.2 10979.5 10990.9 11487.7 11859.2 11893.4 11901.2 11995.8 12238.5 10566.3 11408.1 11675.4 11744.6 12096.5 11272.7 11658.3 11745.5 12147.1 12493.6 12155.0 12158.0 12396.6 12490.3 13083.8 8235.8 9970.0 10367.1 10769.8 11044.9 6930.3 8967.2 10019.7 10505.8 10545.2 03:12:49 INFO - PROCESS | 1631 | -------- Summary: end -------- 03:12:49 INFO - PROCESS | 1631 | 03:12:49 INFO - TEST-INFO | 1631: exit 0 03:12:49 INFO - TEST-OK | dromaeo_css | took 1118834ms 03:12:49 INFO - TEST-START | kraken 03:12:49 INFO - operating with platform_type : mac_ 03:12:49 INFO - Initialising browser for kraken test... 03:12:49 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpEaLhQF/profile http://localhost:49237/getInfo.html) 03:12:52 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 03:12:52 INFO - PROCESS | 1641 | colorDepth:24 03:12:52 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 03:12:52 INFO - PROCESS | 1641 | __metrics 03:12:52 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:12:52 INFO - PROCESS | 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:12:53 INFO - TEST-INFO | 1641: exit 0 03:12:53 INFO - Browser initialized. 03:12:53 INFO - Running cycle 1/1 for kraken test... 03:12:53 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpEaLhQF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:13:05 INFO - PROCESS | 1642 | RSS: Main: 221790208 03:13:05 INFO - PROCESS | 1642 | 03:13:08 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 03:13:09 INFO - PROCESS | 1642 | RSS: Main: 272261120 03:13:09 INFO - PROCESS | 1642 | 03:13:11 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 03:13:12 INFO - PROCESS | 1642 | RSS: Main: 284246016 03:13:12 INFO - PROCESS | 1642 | 03:13:15 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 03:13:16 INFO - PROCESS | 1642 | RSS: Main: 381874176 03:13:16 INFO - PROCESS | 1642 | 03:13:18 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 03:13:18 INFO - PROCESS | 1642 | RSS: Main: 283512832 03:13:18 INFO - PROCESS | 1642 | 03:13:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:13:21 INFO - PROCESS | 1642 | RSS: Main: 284581888 03:13:21 INFO - PROCESS | 1642 | 03:13:24 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 03:13:24 INFO - PROCESS | 1642 | RSS: Main: 324247552 03:13:24 INFO - PROCESS | 1642 | 03:13:27 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 03:13:28 INFO - PROCESS | 1642 | RSS: Main: 326299648 03:13:28 INFO - PROCESS | 1642 | 03:13:31 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 03:13:31 INFO - PROCESS | 1642 | RSS: Main: 325771264 03:13:31 INFO - PROCESS | 1642 | 03:13:33 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:13:34 INFO - PROCESS | 1642 | RSS: Main: 299900928 03:13:34 INFO - PROCESS | 1642 | 03:13:36 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:13:36 INFO - PROCESS | 1642 | RSS: Main: 302059520 03:13:36 INFO - PROCESS | 1642 | 03:13:38 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:13:39 INFO - PROCESS | 1642 | RSS: Main: 304140288 03:13:39 INFO - PROCESS | 1642 | 03:13:42 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:13:43 INFO - PROCESS | 1642 | RSS: Main: 322187264 03:13:43 INFO - PROCESS | 1642 | 03:13:45 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:13:46 INFO - PROCESS | 1642 | RSS: Main: 314707968 03:13:46 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 03:13:48 INFO - PROCESS | 1642 | RSS: Main: 359124992 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | __start_tp_report 03:13:48 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 03:13:48 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 03:13:48 INFO - PROCESS | 1642 | |i|pagename|runs| 03:13:48 INFO - PROCESS | 1642 | |0;ai-astar;117;113;114;114;114;114;115;114;114;115 03:13:48 INFO - PROCESS | 1642 | |1;audio-beat-detection;145;109;109;137;111;111;105;111;139;116 03:13:48 INFO - PROCESS | 1642 | |2;audio-dft;181;187;183;185;185;179;183;184;184;182 03:13:48 INFO - PROCESS | 1642 | |3;audio-fft;79;59;58;89;61;59;61;58;84;58 03:13:48 INFO - PROCESS | 1642 | |4;audio-oscillator;86;70;93;69;69;70;89;68;68;92 03:13:48 INFO - PROCESS | 1642 | |5;imaging-gaussian-blur;91;88;91;88;90;86;91;88;91;87 03:13:48 INFO - PROCESS | 1642 | |6;imaging-darkroom;107;150;150;95;133;149;96;110;149;109 03:13:48 INFO - PROCESS | 1642 | |7;imaging-desaturate;84;86;83;82;82;80;85;84;83;82 03:13:48 INFO - PROCESS | 1642 | |8;json-parse-financial;56;56;53;54;56;58;57;58;57;57 03:13:48 INFO - PROCESS | 1642 | |9;json-stringify-tinderbox;74;70;77;75;73;68;71;70;70;69 03:13:48 INFO - PROCESS | 1642 | |10;stanford-crypto-aes;84;95;102;102;80;83;83;82;83;84 03:13:48 INFO - PROCESS | 1642 | |11;stanford-crypto-ccm;149;144;138;141;139;144;145;157;187;141 03:13:48 INFO - PROCESS | 1642 | |12;stanford-crypto-pbkdf2;163;165;158;165;165;168;164;166;165;162 03:13:48 INFO - PROCESS | 1642 | |13;stanford-crypto-sha256-iterative;66;69;68;67;67;67;66;67;65;65 03:13:48 INFO - PROCESS | 1642 | __end_tp_report 03:13:48 INFO - PROCESS | 1642 | __start_cc_report 03:13:48 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,2105 03:13:48 INFO - PROCESS | 1642 | __end_cc_report 03:13:48 INFO - PROCESS | 1642 | __startTimestamp1484910828543__endTimestamp 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | ------- Summary: start ------- 03:13:48 INFO - PROCESS | 1642 | Number of tests: 14 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:0.60 03:13:48 INFO - PROCESS | 1642 | Values: 117.0 113.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 115.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#1] audio-beat-detection Cycles:10 Average:119.30 Median:113.50 stddev:14.89 (13.1%) stddev-sans-first:12.56 03:13:48 INFO - PROCESS | 1642 | Values: 145.0 109.0 109.0 137.0 111.0 111.0 105.0 111.0 139.0 116.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:2.26 (1.2%) stddev-sans-first:2.24 03:13:48 INFO - PROCESS | 1642 | Values: 181.0 187.0 183.0 185.0 185.0 179.0 183.0 184.0 184.0 182.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#3] audio-fft Cycles:10 Average:66.60 Median:61.00 stddev:12.29 (20.1%) stddev-sans-first:12.18 03:13:48 INFO - PROCESS | 1642 | Values: 79.0 59.0 58.0 89.0 61.0 59.0 61.0 58.0 84.0 58.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.00 stddev:11.02 (14.1%) stddev-sans-first:11.24 03:13:48 INFO - PROCESS | 1642 | Values: 86.0 70.0 93.0 69.0 69.0 70.0 89.0 68.0 68.0 92.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:90.50 stddev:1.91 (2.1%) stddev-sans-first:1.90 03:13:48 INFO - PROCESS | 1642 | Values: 91.0 88.0 91.0 88.0 90.0 86.0 91.0 88.0 91.0 87.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#6] imaging-darkroom Cycles:10 Average:124.80 Median:149.50 stddev:23.60 (15.8%) stddev-sans-first:24.13 03:13:48 INFO - PROCESS | 1642 | Values: 107.0 150.0 150.0 95.0 133.0 149.0 96.0 110.0 149.0 109.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#7] imaging-desaturate Cycles:10 Average:83.10 Median:83.50 stddev:1.73 (2.1%) stddev-sans-first:1.80 03:13:48 INFO - PROCESS | 1642 | Values: 84.0 86.0 83.0 82.0 82.0 80.0 85.0 84.0 83.0 82.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.62 (2.8%) stddev-sans-first:1.72 03:13:48 INFO - PROCESS | 1642 | Values: 56.0 56.0 53.0 54.0 56.0 58.0 57.0 58.0 57.0 57.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:2.91 (4.0%) stddev-sans-first:2.96 03:13:48 INFO - PROCESS | 1642 | Values: 74.0 70.0 77.0 75.0 73.0 68.0 71.0 70.0 70.0 69.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:83.00 stddev:8.48 (10.2%) stddev-sans-first:8.89 03:13:48 INFO - PROCESS | 1642 | Values: 84.0 95.0 102.0 102.0 80.0 83.0 83.0 82.0 83.0 84.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:144.50 stddev:14.61 (10.1%) stddev-sans-first:15.49 03:13:48 INFO - PROCESS | 1642 | Values: 149.0 144.0 138.0 141.0 139.0 144.0 145.0 157.0 187.0 141.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:165.00 stddev:2.69 (1.6%) stddev-sans-first:2.82 03:13:48 INFO - PROCESS | 1642 | Values: 163.0 165.0 158.0 165.0 165.0 168.0 164.0 166.0 165.0 162.0 03:13:48 INFO - PROCESS | 1642 | 03:13:48 INFO - PROCESS | 1642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.30 03:13:48 INFO - PROCESS | 1642 | Values: 66.0 69.0 68.0 67.0 67.0 67.0 66.0 67.0 65.0 65.0 03:13:48 INFO - PROCESS | 1642 | -------- Summary: end -------- 03:13:48 INFO - PROCESS | 1642 | 03:13:49 INFO - TEST-INFO | 1642: exit 0 03:13:49 INFO - TEST-OK | kraken | took 59726ms 03:13:49 INFO - SUITE-END | took 1178s 03:13:49 INFO - Completed test suite (00:19:38) 03:13:49 INFO - javascript benchmark 03:13:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3187.6174859016924, 3336.866525338987, 3343.8328083595816, 3354.8825791097315, 3415.538902248196, 4433.512313645497, 5156.407013193484, 5727.255456790612, 5733.913991290134, 5757.683327416996, 5650.434956504358, 5753.948495289687, 5762.135679648044, 5777.335606405265, 5821.912671309923, 5186.170212765949, 5201.219817027439, 5219.138842091051, 5235.947640523584, 5274.208868669711, 5117.257997590347, 5119.56483698886, 5121.436641969381, 5147.845564633067, 5359.062164121283, 5287.894242115175, 5293.020791153649, 5300.946990530084, 5318.0161670090965, 5346.4118946916005, 5284.762185701634, 5294.841154765363, 5305.602079843989, 5311.5750739941095, 5318.1225097859, 5096.719680417576, 5170.663906846043, 5242.370915490127, 5243.816466423695, 5275.314209152785, 5615.887682246373, 5626.043572592669, 5675.829725108253, 5691.430856914317, 5745.1382292656435, 6165.383461653799, 6214.65819379934, 6249.375162457748, 6257.311695713468, 6289.811305660792, 6250.718717657716, 6263.812085637393, 6295.024271237966, 6295.338989406092, 6309.179806625109, 4374.650027997753, 5606.831795046155, 5722.799702010493, 5811.738471768781, 5853.180554722342, 6208.1308616793685, 6242.500599951993, 6245.750169993149, 6257.56197066201, 6268.122462855204, 5992.790252341147, 6158.476529494954, 6193.566450348522, 6199.690015499207, 6202.0, 5494.148406996922, 6047.727852246571, 6096.786612468631, 6100.816975490742, 6188.44304012641, 6190.969045154746, 6253.7185826637915, 6262.624242545462, 6278.372162783685, 6285.371462853678, 6144.846378840565, 6266.937330626726, 6267.905981410283, 6273.592216505913, 6292.937070629327, 4788.257820037899, 4967.701937883667, 4972.776225069881, 4978.65149439543, 4985.376827896513, 4275.29457639486, 4367.30123180296, 4382.978085109554, 4386.122775444924, 4395.296752519582, 5796.42035796417, 5805.042168042226, 5813.767449302065, 5828.679422631796, 5854.034084376115, 6191.380861913773, 6252.062190671436, 6258.061290806416, 6269.310375858743, 6296.937030629727, 5688.0, 5694.345150307685, 5711.857203569861, 5759.625624334405, 5764.567657425626, 5362.142057270896, 5362.65142765719, 5393.029254734107, 5408.702521361363, 5438.265834112344, 5375.59683023767, 6228.47058000066, 6319.178506794179, 6330.240371155491, 6346.682665866781, 4679.836205732783, 6117.766507567455, 6148.938510614837, 6229.844253893508, 6248.625082495065, 6173.382661733791, 6198.938010619836, 6207.255129384503, 6269.435750782452, 6285.622862628257, 6141.048137538689, 6187.84530386744, 6195.96902015487, 6216.844578885564, 6236.6258024518675, 6211.782587609412, 6252.0, 6272.18461599989, 6278.497720182283, 6291.937080629318, 6001.3998600141385, 6059.484943779828, 6066.1507388966465, 6069.817905462844, 6116.26604807426, 6118.223266370627, 6118.776841100606, 6127.892078906909, 6136.5090792737365, 6143.174139895698, 5945.494632956074, 5966.671833049224, 6017.548683848817, 6027.668478233739, 6041.335453100243, 5888.646681199141, 5924.703764811656, 5927.555433342431, 5976.372480889444, 6139.478144357601, 5714.257146570919, 5775.306963164448, 5808.854778630568, 5812.9709351452975, 5822.505087067647], "value": 5665.734480352046, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.8804131029208, 517.1751057063982, 522.4096770649165, 525.4850246758177, 550.7714298566095, 29851.0, 39548.0, 40554.78335649935, 40728.185436291256, 42404.57595424045, 41711.791441042755, 42071.0, 42187.57812421875, 42193.57806421942, 42336.78831605845, 9260.953695231532, 9411.105944935254, 9417.340786144938, 9428.198603118743, 9430.29272804539, 9279.21126704231, 9378.624855005792, 9382.671606493774, 9393.107654772819, 9447.149756521912, 8036.758897233063, 9307.0, 9343.43939363637, 9368.0, 9382.437053776795, 9340.486273254968, 9371.34400591959, 9380.90619093814, 9384.765380865465, 9402.012788657195, 9147.54262286883, 9232.30757693169, 9237.769055773591, 9241.861372079424, 9248.676296329664, 39531.80234098811, 39934.400983985266, 39936.400953985714, 39939.80030099831, 40027.79986100051, 3261.4618587932964, 3344.3812894614575, 3410.0792785947656, 3458.1354661334667, 3607.92730488527, 28594.571081433794, 29513.704862951312, 29779.49556513544, 30121.849390753126, 31611.683883161106, 3155.984220078908, 3195.121341631047, 3205.294835136266, 3206.5671134397026, 3239.82180980046, 414698.0, 486067.0, 496552.0, 497182.0, 499063.9999999964, 64182.0, 65455.0, 65489.67255163789, 65561.01658475031, 65573.34426655673, 28945.85527072351, 36162.8191859039, 36557.45163822545, 69242.30757692459, 69688.0, 15893.046417215004, 16245.675086498204, 16259.0, 16276.10481423533, 16276.918615407085, 12325.568605098779, 12427.44076516559, 12431.067669924792, 12441.93779031099, 12476.313802740937, 19699.916504592384, 19710.0, 20005.399838004883, 20437.978101094886, 20444.0578145076, 8089.555074470843, 8107.959460202661, 8225.424220304641, 8259.587020648944, 8304.626291816883, 826.5206180415345, 911.0297533127198, 944.7590864329552, 954.7040417470606, 1076.1390887290293, 28704.856475717486, 29310.85344573306, 29642.851785741364, 30059.549106763418, 30446.0, 1069.6416700405296, 1073.6510634043966, 1077.719792853848, 1109.9334039957466, 1131.4060118437721, 13185.934070329587, 15233.542993710207, 15438.5368438947, 15552.455664051704, 15751.887777794445, 704364.0, 713753.4312328509, 715421.0, 715559.0, 718063.0, 57598.42401575931, 58470.0, 60835.39164608297, 60948.39051609516, 61004.779904401665, 1373.6085215713674, 1391.0818859552646, 1414.7099844532052, 1417.333853089026, 1418.0569921002418, 29742.10773676793, 30691.386172275983, 31111.84444077765, 31165.220869478446, 31718.841405792824, 51503.484965149866, 52012.21981670354, 52053.0, 52080.73959630178, 52094.0, 600036.0, 603008.9849550724, 603758.0, 603902.0, 604978.0, 42006.789966049975, 42388.78805605952, 43095.0, 43144.78427607842, 43163.0, 46527.76736116298, 46558.53441465677, 46764.7661761689, 47075.0, 47515.57453276407, 32385.35229295448, 35262.0, 38321.61678383292, 38933.22133557256, 40405.59594404136, 38420.42369364518, 38514.422283666325, 38634.8409547714, 38983.22033559256, 38989.0, 36474.635253648186, 37964.2407151861, 38579.0, 38726.03184920287, 40127.799361004174, 31463.0, 34506.309873802886, 34546.480674048755, 35088.64911350956, 35179.47230791489, 20370.0, 25676.743232567434, 25691.614625781003, 25901.6114758275, 26716.465670686866], "value": 20185.358555701638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3019231344996, 370.3722190886448, 374.1674773628675, 380.4426515155298, 399.55649229355413, 12779.680507987294, 14555.927220363896, 14918.477853275137, 19462.221511139538, 19991.700124498144, 18930.810691893075, 19413.805861941375, 19928.50178745532, 20050.699239511418, 20480.590388192228, 5793.478586927165, 6105.023196288595, 6115.755369785204, 6121.755129794803, 6130.478909292693, 4768.950830817214, 5936.050231962887, 5991.610545314541, 6007.609505382136, 6009.1587177795145, 5634.183043458696, 5941.316748573926, 5947.0, 5948.672822994755, 5960.582759206857, 5340.092184328634, 5664.971675141598, 5876.9118463223085, 5962.463378295931, 5966.134910437984, 5005.499450054966, 5212.0, 5216.7913283468615, 5222.399424066243, 5301.0723123453245, 13035.0, 13066.954643628487, 13191.538296159684, 13301.667458313523, 13349.933250333783, 1939.486036200394, 2179.7711240319854, 2276.7950884420484, 2288.988555057214, 2308.6306191009526, 9923.454210018446, 10432.165426765916, 10523.631672891412, 12427.627171184879, 14456.638584035378, 1812.151843430087, 1841.9815801841944, 1854.0729635182408, 1890.8203720646516, 1920.9807901920942, 104910.0, 115374.65439400829, 120383.0, 123277.38361308226, 126697.0, 9409.435433873989, 9739.707808765748, 9897.950510247403, 10103.949480252551, 10247.0, 11998.0, 12373.75252494945, 12395.566155184526, 12432.813507797391, 12491.812622810665, 7751.844963100706, 8000.039995200613, 8010.959945200237, 8072.596370181467, 8092.959535202404, 8210.425270231026, 8225.71210007647, 8233.0, 8355.958220208982, 8385.454945428528, 3285.671432856743, 3893.8831835044994, 3894.1043559981363, 3987.063040185554, 3992.3612222044335, 1870.887746735173, 1907.8282954533881, 1921.2987259650406, 1922.5097600112163, 1930.7972662870477, 650.4601181019742, 697.5704277835703, 711.8860982242817, 822.0687737970571, 872.7774417523618, 19906.701399479018, 21168.941552922293, 21366.465838353855, 21448.892755536122, 21468.0, 891.8573028315568, 899.8965119011398, 902.4630344944748, 907.2197909797569, 915.9633614655472, 10736.838947415796, 10775.976282253174, 11188.888111118948, 11287.887121128848, 11337.773244535063, 539891.0, 543355.0, 559748.0, 578941.0, 581439.0, 94452.0, 118842.0, 119950.40024799995, 120305.39847300883, 123243.38378308051, 808.7129069180356, 906.1482206725657, 928.679605536089, 943.1558754914313, 946.5503885654397, 18459.169337379582, 19219.0, 19556.511087222934, 19583.412497625093, 19589.80410195937, 39879.80060099681, 40281.0, 51666.225006624176, 52076.739616301675, 53119.20321195108, 53783.46216537941, 73091.63454182695, 74293.25706742864, 79105.60447197728, 81444.0, 7949.92050079515, 8074.1522140176785, 8188.0, 8293.21214484623, 8310.792230194293, 11985.64043078709, 12216.633500994983, 12264.202826816228, 12816.6795830105, 12896.935515322364, 11348.092152627934, 11357.886421135683, 11426.428678566204, 11859.466324015613, 11903.047756179658, 9879.20966322678, 10386.013328733758, 11090.611828585961, 11093.722656933642, 11429.771404571695, 11508.654740357802, 11856.992155666865, 11906.40467976615, 11950.880491195325, 12049.939750301193, 8017.8797318039105, 8322.62548185321, 8395.832083358177, 8401.495910245405, 8421.410501264852, 8146.266835984789, 8606.741797746077, 10802.945985270338, 11084.946930041633, 11242.66272011841], "value": 9022.378844618925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.4327925550524, 1442.1995792335254, 1589.8807589430796, 1798.1009495252374, 1823.6170404215122, 8033.799155021127, 8408.873866892001, 8432.494050356976, 8463.619137138829, 8477.237048665618, 7291.562506249628, 7597.0, 7601.923980760191, 8045.839083218332, 8299.543525106117, 2250.2349201271522, 2286.6112760830697, 2289.1530133850497, 2289.919852805152, 2290.9656355154684, 2283.56612243674, 2314.0628045641542, 2332.918347857825, 2335.836491445591, 2337.0, 2313.595120853852, 2314.4908120213527, 2330.4872927955907, 2333.708286464192, 2338.53229354129, 2028.3407892435018, 2072.98963505183, 2091.435312465626, 2292.106078629336, 2318.119114736406, 2322.6632138339846, 2343.7070366204225, 2345.777151170636, 2347.5891718949288, 2350.4593943393115, 8191.0, 8376.329893608558, 8383.203595658464, 8384.664613415456, 8395.790105247357, 4981.750912454399, 5134.306868572732, 5138.075146473633, 5138.10083235436, 5145.871353216162, 3262.5106234064842, 3323.6510166432417, 3568.518250036238, 3572.732045096602, 3584.5698516178227, 964.6623681711415, 1037.4397825174397, 1057.9682609521726, 1095.2497539185683, 1104.4588151805638, 10737.302075365154, 10859.891401086046, 10926.344419334866, 11006.174536909684, 11048.447577621087, 4477.0, 4571.634269258451, 4656.511066338054, 4663.650226233046, 4734.171519983989, 9438.575264112995, 9443.150116489549, 9444.338896277332, 9463.148316651534, 9463.90536094644, 5050.6464547482055, 5137.460566640524, 5162.6902385856965, 5174.7153906535505, 5187.792488300426, 4217.7891105444605, 4332.610065094157, 4554.0, 4602.240630296031, 4693.7653117344, 3301.3892429900066, 3780.3762379207124, 3781.0, 3858.864939727096, 3886.7473614214987, 1217.11150859871, 1217.6225370135287, 1221.2977537915733, 1227.0674287541533, 1227.1348699167065, 798.6126728536655, 861.4917198852708, 894.9373543851998, 898.6944438890808, 911.7082533589188, 5607.80372686954, 5691.317041954909, 5806.88386232273, 5814.30228372598, 5887.676177810262, 832.6710949175042, 908.3777612335439, 910.6311943662827, 923.5566927874657, 940.0740270833223, 3677.0, 3727.0682329417646, 3757.267332870119, 3807.4098514730263, 3847.788371639531, 9854.310198286195, 10234.130098941674, 10251.179905607683, 10276.22928280367, 10282.537285822156, 9908.455034973002, 9974.0, 10216.438095904648, 10221.080102790784, 10236.53935572901, 7741.651625676858, 7846.3330616897065, 7872.134065252818, 7878.487898286708, 7901.644426000844, 5312.150055991023, 5429.592780541554, 5511.696856672921, 5649.858753531194, 5680.829575112753, 7732.342750866239, 9263.16631503168, 9411.623535058794, 9444.386114902509, 9471.147596716328, 7860.6069696513805, 9073.230720009535, 9418.529073546159, 9440.575174117319, 9490.430574165572, 6557.540972131905, 6773.89839152423, 6783.18601767791, 7185.886187640924, 7358.190599034209, 7405.518641288299, 7492.1384040836, 7500.212477689764, 7542.434317426105, 7682.385409167141, 5748.913766293593, 7184.209736928829, 7229.783106506813, 7231.891521627074, 7323.414126869731, 7043.929560704328, 7082.858342833218, 7109.644517773987, 7114.750983715545, 7173.856522869618, 5634.464725851038, 6527.771527996498, 6566.310537393505, 6645.833854153685, 6721.428678562377, 4209.978950105352, 4649.442066951988, 4707.435107787088, 4802.135615589227, 4891.877703057452, 4752.239641657318, 4776.2119250324695, 4848.490908454562, 4894.975525122351, 5030.924536131888], "value": 4374.301145012364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.84600238872207, 290.765933423594, 302.164515115705, 311.80667985848777, 315.4023126175898, 5195.922061169081, 5270.446603106676, 5286.959998001145, 5301.6818990860575, 5307.73461326934, 4184.932842125261, 4329.203380597049, 4576.267797152448, 4883.0, 5031.748412579374, 4013.819378127984, 4049.311617025113, 4062.3344428784203, 4104.42538044674, 4117.855875044374, 3580.3888250287346, 3847.576766555677, 4070.9389359159636, 4079.1637714268504, 4099.028204551706, 3291.6708329167013, 3334.4664853623426, 3907.0008315946156, 3999.180168065554, 4058.336082206296, 4002.6584448097897, 4005.319095753729, 4005.619466150711, 4026.0740029793164, 4052.1909405159204, 3493.283876805249, 3495.3883070462566, 3515.4023815951095, 3528.576570811493, 3531.593866705336, 4774.734695305747, 4815.0, 5063.39235293824, 5096.872578185538, 5131.512506311894, 4025.9733767889, 4155.335146376596, 4612.677112602119, 4645.837395691135, 4651.441647139941, 4450.621697155746, 4760.785764640599, 4828.8893554482665, 5472.26124473195, 5504.724763761796, 3251.7398608111293, 3324.750643701732, 3365.788316206164, 3739.775613463201, 3891.6886649068006, 4836.210602077219, 4848.884756506023, 4989.401271847365, 5385.434529374398, 5739.426057394227, 3332.233586275122, 3917.6082391760597, 3927.8821635350987, 3943.8422463101156, 3972.483577134954, 3652.2695460907926, 3714.88855334335, 4020.798960051986, 4029.3351596986754, 4049.5545489996666, 3573.4997100405963, 4600.033992861537, 4658.627309815207, 4674.953250467452, 4700.929486057712, 4451.9554804451545, 5537.36320323168, 5542.418046105101, 5543.722813859291, 5571.832845014656, 1241.3731065811708, 1289.3939848271298, 1301.9519286973887, 1309.7838856588555, 1311.4819646239682, 778.373409405434, 784.6429874407131, 840.2899549880341, 859.737779977113, 895.7357579514058, 3938.1139243669945, 4368.6723495737315, 4851.660383773102, 4853.975730121398, 4930.975345123252, 4609.8847528811375, 4815.109204797123, 5008.474110218447, 5213.488088454305, 5316.787328506894, 4552.975580494429, 4570.674504393689, 4609.838655647036, 4810.470848206694, 4873.342098816685, 2247.4156719252783, 2489.3776555861036, 2589.52093862636, 2632.328756167165, 2832.8017038807084, 4692.389989301369, 5487.228949380537, 5491.7254137292975, 5534.229046705016, 5578.41426650204, 4645.9325600108305, 4829.806807727651, 5280.762365693553, 5409.864753381118, 5417.83746487606, 4878.975605121952, 5088.720120393414, 5441.8095366662765, 5448.6378405398655, 5481.506664400223, 5295.7352132394, 5299.30422264887, 5317.308749862493, 5332.093544097435, 5389.353277606556, 4555.8177672894035, 4807.302941073455, 4914.950850491592, 5251.868703282295, 5252.789888404421, 4427.358033085249, 5396.5699089740465, 5398.676079435247, 5454.2003037326895, 5454.463674391427, 3228.773985821064, 3298.5711857458377, 3728.6084961078695, 3757.7369584128846, 3764.3600587899573, 4883.706977581356, 5169.586433085269, 5335.546478549211, 5344.759485823225, 5385.75764090609, 3956.723029387915, 5009.448960614257, 5118.769655365592, 5165.070287348163, 5215.348081489814, 3985.6811455084103, 4471.311168286112, 4622.560856718606, 4782.141876201626, 4991.575716064175, 4738.384010078806, 4829.66192366531, 4972.900541989212, 5004.599632029356, 5143.5627971622835, 4575.3823233863, 4889.828855990023, 5359.517643412111, 5368.597355198453, 5534.806281780118, 4744.88137796544, 4772.5227477252, 4778.737169455713, 5460.535854452416, 5466.125419932791], "value": 3863.6257515801394, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.1484431571323, 696.52636207379, 700.5796522086746, 751.6692655231695, 760.9353204977576, 13813.96395270355, 14175.574732758021, 14181.503647372345, 14183.149011059344, 14185.290735463237, 12649.62051138465, 12957.157784743986, 14177.291135443238, 14726.558203253893, 14732.0424172429, 658.7562601837327, 809.3323008517967, 834.8664213725805, 835.8799209059858, 835.9331253499705, 664.0802488553364, 673.3199468536765, 787.9724209652663, 809.7732634862248, 823.4359463767308, 879.0594064351114, 881.6517475597135, 881.6561540999015, 881.9029906710257, 882.5631312500321, 873.8470767615673, 874.3617159473556, 874.7463235661651, 875.1991927386402, 877.9771566125456, 453.53059583331094, 497.33958068614965, 515.6493584362632, 623.5198896849446, 630.9432151106377, 14251.002429829916, 14275.643108922257, 14293.070950388192, 14297.14217146964, 14301.213433261271, 12316.829901159375, 12343.691407714789, 12586.307753073577, 12793.232406055666, 12812.039097067664, 10531.631392901289, 11981.460834262392, 12100.576479823252, 12134.0, 12137.0, 3551.982240088783, 3580.4092324766384, 3713.610070942539, 4273.209456250573, 4305.354196870463, 77248.61375693142, 78763.99999999943, 80349.0, 82768.0, 82949.58525207396, 7990.452036401634, 8731.039585645574, 9908.0, 10161.646656603303, 10186.949065254626, 19636.312729054414, 19657.901710491642, 19672.0, 19685.11416986239, 19795.703064454046, 7064.0, 7107.609081500567, 7453.552786832807, 7491.400687944952, 7497.2877576630135, 3556.41319182332, 4012.598740126022, 4125.876223713293, 4224.598663126998, 4243.42713733642, 3268.2156282492033, 3326.7837590556537, 3373.6120346160014, 3391.1522119470133, 3395.2360718838063, 612.3325575123138, 614.241411856357, 622.4553515673786, 622.4802290087828, 628.3496581038694, 548.6598309048416, 565.0559097499477, 623.7255607532762, 625.7997440818986, 672.085963090197, 8649.524276164746, 8717.782055448664, 8771.342149338825, 8970.443423624236, 9175.58709858058, 506.82261208576705, 542.4169018305338, 600.3486217454024, 650.6291413894035, 670.1823774994499, 4093.836246550164, 4310.353446982977, 4319.784010799447, 4320.395144679747, 4420.646348292129, 106082.46958765156, 106395.46802266093, 113868.0, 114252.0, 115407.0, 87759.0, 89026.0, 93065.5346723262, 93655.59516607257, 97028.0, 80948.7857682147, 82078.35843283101, 82317.58841205755, 82983.5850820742, 83337.3332533346, 8392.87410688828, 8550.91449085526, 8596.269317107866, 8691.304695624209, 8773.824523509622, 41576.79211603923, 49142.75428622834, 52951.0, 56573.71713141408, 56772.58068548319, 77847.10764461868, 78894.0, 79512.84900611357, 80324.59837700774, 81541.0, 10820.296680715728, 10922.235443518877, 10979.451027448755, 10990.945045274722, 11487.655370338904, 11859.182751723501, 11893.405329733305, 11901.226420282654, 11995.820062698893, 12238.510459581517, 10566.260361774603, 11408.144389170679, 11675.416229188337, 11744.647660570197, 12096.516139354328, 11272.66182014541, 11658.300501969909, 11745.47145378443, 12147.149699520949, 12493.625191244277, 12155.02759779198, 12158.0, 12396.624178103206, 12490.313032783284, 13083.803742943674, 8235.752927412188, 9969.950150249202, 10367.066963972977, 10769.838452423377, 11044.889551104387, 6930.341617546325, 8967.237784788365, 10019.749506262402, 10505.789884202426, 10545.209109316678], "value": 6973.908952406309, "unit": "score"}], "name": "dromaeo_css", "value": 7038.940617108673, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 109.0, 137.0, 111.0, 111.0, 105.0, 111.0, 139.0, 116.0], "value": 119.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 187.0, 183.0, 185.0, 185.0, 179.0, 183.0, 184.0, 184.0, 182.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 89.0, 61.0, 59.0, 61.0, 58.0, 84.0, 58.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 93.0, 69.0, 69.0, 70.0, 89.0, 68.0, 68.0, 92.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 88.0, 90.0, 86.0, 91.0, 88.0, 91.0, 87.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 150.0, 150.0, 95.0, 133.0, 149.0, 96.0, 110.0, 149.0, 109.0], "value": 124.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 82.0, 82.0, 80.0, 85.0, 84.0, 83.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 53.0, 54.0, 56.0, 58.0, 57.0, 58.0, 57.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 77.0, 75.0, 73.0, 68.0, 71.0, 70.0, 70.0, 69.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 95.0, 102.0, 102.0, 80.0, 83.0, 83.0, 82.0, 83.0, 84.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 144.0, 138.0, 141.0, 139.0, 144.0, 145.0, 157.0, 187.0, 141.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 158.0, 165.0, 165.0, 168.0, 164.0, 166.0, 165.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 67.0, 67.0, 67.0, 66.0, 67.0, 65.0, 65.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1453.0, "alertThreshold": 2.0}]} 03:13:49 INFO - Return code: 0 03:13:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:13:49 INFO - # TBPL SUCCESS # 03:13:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:13:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:13:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:13:49 INFO - 2017-01-20 03:13:49.842 screenresolution[1646:10045] starting screenresolution argv=screenresolution get 03:13:49 INFO - 2017-01-20 03:13:49.846 screenresolution[1646:10045] Display 0: 1600x1200x32@60 03:13:49 INFO - 2017-01-20 03:13:49.852 screenresolution[1647:10048] starting screenresolution argv=screenresolution list 03:13:49 INFO - Available Modes on Display 0 03:13:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:13:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:13:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:13:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:13:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:13:50 INFO - Intel Iris: 03:13:50 INFO - Chipset Model: Intel Iris 03:13:50 INFO - Type: GPU 03:13:50 INFO - Bus: Built-In 03:13:50 INFO - VRAM (Dynamic, Max): 1536 MB 03:13:50 INFO - Vendor: Intel (0x8086) 03:13:50 INFO - Device ID: 0x0a2e 03:13:50 INFO - Revision ID: 0x0009 03:13:50 INFO - Displays: 03:13:50 INFO - Display: 03:13:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:13:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:13:50 INFO - Display Serial Number: 1600x1200 60 03:13:50 INFO - Main Display: Yes 03:13:50 INFO - Mirror: Off 03:13:50 INFO - Online: Yes 03:13:50 INFO - Rotation: Supported 03:13:50 INFO - Return code: 0 03:13:50 INFO - Running post-action listener: _resource_record_post_action 03:13:50 INFO - [mozharness: 2017-01-20 11:13:50.094929Z] Finished run-tests step (success) 03:13:50 INFO - Running post-run listener: _resource_record_post_run 03:13:50 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 38642688; Write bytes: 659640832; Read time: 409; Write time: 1972 03:13:50 INFO - TinderboxPrint: CPU usage
53.5% 03:13:50 INFO - TinderboxPrint: I/O read bytes / time
38,642,688 / 409 03:13:50 INFO - TinderboxPrint: I/O write bytes / time
659,640,832 / 1,972 03:13:50 INFO - TinderboxPrint: CPU idle
2,255.6 (46.5%) 03:13:50 INFO - TinderboxPrint: CPU system
970.3 (20.0%) 03:13:50 INFO - TinderboxPrint: CPU user
1,619.8 (33.4%) 03:13:50 INFO - TinderboxPrint: Swap in / out
387,862,528 / 0 03:13:50 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 346509824; Write bytes: 346426880; Read time: 27823; Write time: 650 03:13:50 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 36258816; Write bytes: 305910784; Read time: 382; Write time: 1293 03:13:50 INFO - Running post-run listener: _upload_blobber_files 03:13:50 INFO - Blob upload gear active. 03:13:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:13:50 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 03:13:50 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:13:50 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:13:50 INFO - (blobuploader) - INFO - Open directory for files ... 03:13:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:13:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:52 INFO - (blobuploader) - INFO - Done attempting. 03:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:53 INFO - (blobuploader) - INFO - Done attempting. 03:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:13:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:55 INFO - (blobuploader) - INFO - Done attempting. 03:13:55 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:55 INFO - Return code: 0 03:13:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91492a8c667d1151209a27da80a7ba0372a235db6823934db3a0d6e66f1707c53a9b1fc24249bcfc6c6c3b8eda23ab5dbd620fe065b6715b165ff8cab51127e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f783e4be84717ff345c6a64e814ef942d9b92ab3b3f63b8d133eb6e03480265d13b11ce8177be69ead743bfadb7cb4e535354eda8989b2b2d7df0bf6f625d1e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7910dc2256814bae90d29a6c8bc68308813ab15519a6ac974e3be196ba5e0edcf8f1b5b4db2d676f976f139776eabbd23c2b52fbe21420b27c1f61a6dc4e489e"} 03:13:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:55 INFO - Contents: 03:13:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91492a8c667d1151209a27da80a7ba0372a235db6823934db3a0d6e66f1707c53a9b1fc24249bcfc6c6c3b8eda23ab5dbd620fe065b6715b165ff8cab51127e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f783e4be84717ff345c6a64e814ef942d9b92ab3b3f63b8d133eb6e03480265d13b11ce8177be69ead743bfadb7cb4e535354eda8989b2b2d7df0bf6f625d1e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7910dc2256814bae90d29a6c8bc68308813ab15519a6ac974e3be196ba5e0edcf8f1b5b4db2d676f976f139776eabbd23c2b52fbe21420b27c1f61a6dc4e489e"} 03:13:55 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:55 INFO - Copying logs to upload dir... 03:13:55 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.191441 ========= master_lag: 1.20 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2017-01-20 03:13:56.820447) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 03:13:56.824651) ========= 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.1hxZ557g4s/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.ShKMfzNYRH/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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/Mozilla-Aurora/sha512/91492a8c667d1151209a27da80a7ba0372a235db6823934db3a0d6e66f1707c53a9b1fc24249bcfc6c6c3b8eda23ab5dbd620fe065b6715b165ff8cab51127e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f783e4be84717ff345c6a64e814ef942d9b92ab3b3f63b8d133eb6e03480265d13b11ce8177be69ead743bfadb7cb4e535354eda8989b2b2d7df0bf6f625d1e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7910dc2256814bae90d29a6c8bc68308813ab15519a6ac974e3be196ba5e0edcf8f1b5b4db2d676f976f139776eabbd23c2b52fbe21420b27c1f61a6dc4e489e"} build_url:https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91492a8c667d1151209a27da80a7ba0372a235db6823934db3a0d6e66f1707c53a9b1fc24249bcfc6c6c3b8eda23ab5dbd620fe065b6715b165ff8cab51127e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f783e4be84717ff345c6a64e814ef942d9b92ab3b3f63b8d133eb6e03480265d13b11ce8177be69ead743bfadb7cb4e535354eda8989b2b2d7df0bf6f625d1e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7910dc2256814bae90d29a6c8bc68308813ab15519a6ac974e3be196ba5e0edcf8f1b5b4db2d676f976f139776eabbd23c2b52fbe21420b27c1f61a6dc4e489e"}' ========= master_lag: 0.84 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 03:13:57.677639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 03:13:57.678073) ========= 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.1hxZ557g4s/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.ShKMfzNYRH/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.005220 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 03:13:57.717339) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 03:13:57.717685) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 03:13:57.718185) ========= ========= Total master_lag: 2.14 =========