builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0034 starttime: 1478746170.55 results: success (0) buildid: 20161109173721 builduid: 0d25273f2f19412ba2951ae104ab208f revision: 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:30.549155) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:30.549621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:30.549939) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:30.577088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:30.577511) ========= 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.H32j4zdBjG/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.Ql8ckatUZk/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-09 18:49:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-11-09 18:49:31 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.491905 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:31.093163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:31.093515) ========= 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.H32j4zdBjG/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.Ql8ckatUZk/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.027482 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:31.142698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 18:49:31.143125) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 --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 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H32j4zdBjG/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.Ql8ckatUZk/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-09 18:49:31,225 truncating revision to first 12 chars 2016-11-09 18:49:31,225 Setting DEBUG logging. 2016-11-09 18:49:31,225 attempt 1/10 2016-11-09 18:49:31,225 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9c1ca21cf9c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-09 18:49:32,217 unpacking tar archive at: mozilla-aurora-9c1ca21cf9c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.272973 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 18:49:32.440283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:32.440752) ========= script_repo_revision: 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:32.441328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:32.441709) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 18:49:32.462745) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-09 18:49:32.463257) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.H32j4zdBjG/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.Ql8ckatUZk/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:49:32 INFO - MultiFileLogger online at 20161109 18:49:32 in /builds/slave/test 18:49:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:49:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:49:32 INFO - {'append_to_log': False, 18:49:32 INFO - 'base_work_dir': '/builds/slave/test', 18:49:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:49:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:49:32 INFO - 'branch': 'Mozilla-Aurora', 18:49:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:49:32 INFO - 'config_files': ('talos/mac_config.py',), 18:49:32 INFO - 'default_actions': ('clobber', 18:49:32 INFO - 'read-buildbot-config', 18:49:32 INFO - 'download-and-extract', 18:49:32 INFO - 'populate-webroot', 18:49:32 INFO - 'create-virtualenv', 18:49:32 INFO - 'install', 18:49:32 INFO - 'run-tests'), 18:49:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:49:32 INFO - 'download_minidump_stackwalk': True, 18:49:32 INFO - 'download_symbols': 'ondemand', 18:49:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:49:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:49:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:49:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:49:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:49:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:49:32 INFO - 'installer_path': 'installer.exe', 18:49:32 INFO - 'log_level': 'info', 18:49:32 INFO - 'log_name': 'talos', 18:49:32 INFO - 'log_to_console': True, 18:49:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:49:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:49:32 INFO - 'opt_config_files': (), 18:49:32 INFO - 'pip_index': False, 18:49:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:49:32 INFO - 'cmd': ('bash', 18:49:32 INFO - '-c', 18:49:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:49:32 INFO - 'enabled': True, 18:49:32 INFO - 'halt_on_failure': False, 18:49:32 INFO - 'name': 'check_screen_resolution'},), 18:49:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:49:32 INFO - 'cmd': ('bash', 18:49:32 INFO - '-c', 18:49:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:49:32 INFO - 'enabled': True, 18:49:32 INFO - 'halt_on_failure': False, 18:49:32 INFO - 'name': 'check_screen_resolution'},), 18:49:32 INFO - 'run_cmd_checks_enabled': True, 18:49:32 INFO - 'sps_profile': False, 18:49:32 INFO - 'sps_profile_interval': 0, 18:49:32 INFO - 'suite': 'dromaeojs-e10s', 18:49:32 INFO - 'system_bits': '32', 18:49:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:49:32 INFO - 'title': 't-yosemite-r7-0034', 18:49:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:49:32 INFO - 'use_talos_json': True, 18:49:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:49:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:49:32 INFO - 'work_dir': 'build'} 18:49:32 INFO - [mozharness: 2016-11-10 02:49:32.695775Z] Running clobber step. 18:49:32 INFO - Running pre-action listener: _resource_record_pre_action 18:49:32 INFO - Running main action method: clobber 18:49:32 INFO - rmtree: /builds/slave/test/build 18:49:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:49:35 INFO - Running post-action listener: _resource_record_post_action 18:49:35 INFO - [mozharness: 2016-11-10 02:49:35.154378Z] Finished clobber step (success) 18:49:35 INFO - [mozharness: 2016-11-10 02:49:35.154511Z] Running read-buildbot-config step. 18:49:35 INFO - Running pre-action listener: _resource_record_pre_action 18:49:35 INFO - Running main action method: read_buildbot_config 18:49:35 INFO - Using buildbot properties: 18:49:35 INFO - { 18:49:35 INFO - "project": "", 18:49:35 INFO - "product": "firefox", 18:49:35 INFO - "script_repo_revision": "production", 18:49:35 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 18:49:35 INFO - "repository": "", 18:49:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 18:49:35 INFO - "buildid": "20161109173721", 18:49:35 INFO - "pgo_build": "False", 18:49:35 INFO - "basedir": "/builds/slave/test", 18:49:35 INFO - "buildnumber": 446, 18:49:35 INFO - "slavename": "t-yosemite-r7-0034", 18:49:35 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:49:35 INFO - "platform": "yosemite_r7", 18:49:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:49:35 INFO - "branch": "mozilla-aurora", 18:49:35 INFO - "repo_path": "releases/mozilla-aurora", 18:49:35 INFO - "revision": "9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7", 18:49:35 INFO - "stage_platform": "macosx64", 18:49:35 INFO - "builduid": "0d25273f2f19412ba2951ae104ab208f", 18:49:35 INFO - "slavebuilddir": "test" 18:49:35 INFO - } 18:49:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 18:49:35 INFO - Running post-action listener: _resource_record_post_action 18:49:35 INFO - [mozharness: 2016-11-10 02:49:35.158044Z] Finished read-buildbot-config step (success) 18:49:35 INFO - [mozharness: 2016-11-10 02:49:35.158180Z] Running download-and-extract step. 18:49:35 INFO - Running pre-action listener: _resource_record_pre_action 18:49:35 INFO - Running main action method: download_and_extract 18:49:35 INFO - mkdir: /builds/slave/test/build/tests 18:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:35 INFO - trying https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 18:49:35 INFO - Downloading https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 18:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 18:49:36 INFO - Downloaded 1199 bytes. 18:49:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 18:49:36 INFO - Using the following test package requirements: 18:49:36 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:49:36 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:49:36 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 18:49:36 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:49:36 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 18:49:36 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:49:36 INFO - u'jsshell-mac.zip'], 18:49:36 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:49:36 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 18:49:36 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 18:49:36 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:49:36 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 18:49:36 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:49:36 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 18:49:36 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:49:36 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 18:49:36 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 18:49:36 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 18:49:36 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:49:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:49:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:49:36 INFO - Fetch https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:49:36 INFO - Expected file size: 16423309 18:49:44 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:49:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 18:49:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:49:44 INFO - Fetch https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 18:49:44 INFO - Expected file size: 16423309 18:49:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 18:49:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:49:52 INFO - Fetch https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 18:49:52 INFO - Expected file size: 14414089 18:49:53 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')]} 18:49:53 INFO - trying https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:49:53 INFO - Downloading https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 18:49:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 18:49:56 INFO - Downloaded 115541035 bytes. 18:49:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:49:56 INFO - mkdir: /builds/slave/test/properties 18:49:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:49:56 INFO - Writing to file /builds/slave/test/properties/build_url 18:49:56 INFO - Contents: 18:49:56 INFO - build_url:https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 18:49:57 INFO - Running post-action listener: _resource_record_post_action 18:49:57 INFO - Running post-action listener: set_extra_try_arguments 18:49:57 INFO - [mozharness: 2016-11-10 02:49:57.161879Z] Finished download-and-extract step (success) 18:49:57 INFO - [mozharness: 2016-11-10 02:49:57.162013Z] Running populate-webroot step. 18:49:57 INFO - Running pre-action listener: _resource_record_pre_action 18:49:57 INFO - Running main action method: populate_webroot 18:49:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:49:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:49:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:49:57 INFO - '--tppagecycles', 18:49:57 INFO - '7'], 18:49:57 INFO - 'tests': ['tsvgm']}}, 18:49:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:49:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:49:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:49:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:49:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:49:57 INFO - 'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:49:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:49:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:49:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:49:57 INFO - 'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['damp', 'tps']}, 18:49:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:49:57 INFO - 'tests': ['damp', 'tps']}, 18:49:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['dromaeo_dom']}, 18:49:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:49:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['basic_compositor_video']}, 18:49:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:49:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['a11yr', 18:49:57 INFO - 'ts_paint', 18:49:57 INFO - 'tpaint', 18:49:57 INFO - 'sessionrestore', 18:49:57 INFO - 'sessionrestore_no_auto_restore', 18:49:57 INFO - 'tabpaint']}, 18:49:57 INFO - 'other-e10s': {'tests': ['a11yr', 18:49:57 INFO - 'ts_paint', 18:49:57 INFO - 'tpaint', 18:49:57 INFO - 'sessionrestore', 18:49:57 INFO - 'sessionrestore_no_auto_restore', 18:49:57 INFO - 'tabpaint']}, 18:49:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:49:57 INFO - 'ts_paint', 18:49:57 INFO - 'tpaint', 18:49:57 INFO - 'sessionrestore', 18:49:57 INFO - 'sessionrestore_no_auto_restore', 18:49:57 INFO - 'tabpaint']}, 18:49:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:49:57 INFO - 'ts_paint', 18:49:57 INFO - 'tpaint', 18:49:57 INFO - 'sessionrestore', 18:49:57 INFO - 'sessionrestore_no_auto_restore', 18:49:57 INFO - 'tabpaint']}, 18:49:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['a11yr', 18:49:57 INFO - 'ts_paint', 18:49:57 INFO - 'tpaint', 18:49:57 INFO - 'sessionrestore', 18:49:57 INFO - 'sessionrestore_no_auto_restore', 18:49:57 INFO - 'tabpaint']}, 18:49:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['a11yr', 18:49:57 INFO - 'ts_paint', 18:49:57 INFO - 'tpaint', 18:49:57 INFO - 'sessionrestore', 18:49:57 INFO - 'sessionrestore_no_auto_restore', 18:49:57 INFO - 'tabpaint']}, 18:49:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['tsvgx', 18:49:57 INFO - 'tsvgr_opacity', 18:49:57 INFO - 'tart', 18:49:57 INFO - 'tscrollx', 18:49:57 INFO - 'cart']}, 18:49:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:49:57 INFO - 'tsvgr_opacity', 18:49:57 INFO - 'tart', 18:49:57 INFO - 'tscrollx', 18:49:57 INFO - 'cart']}, 18:49:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:49:57 INFO - 'talos_options': ['--disable-e10s'], 18:49:57 INFO - 'tests': ['tp5o']}, 18:49:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:49:57 INFO - 'tests': ['tp5o']}, 18:49:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:49:57 INFO - 'talos_options': ['--disable-e10s', 18:49:57 INFO - '--xperf_path', 18:49:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:49:57 INFO - 'tests': ['tp5n']}, 18:49:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:49:57 INFO - 'talos_options': ['--xperf_path', 18:49:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:49:57 INFO - 'tests': ['tp5n']}}, 18:49:57 INFO - 'talos.zip': {'path': '', 18:49:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:49:57 INFO - Running post-action listener: _resource_record_post_action 18:49:57 INFO - [mozharness: 2016-11-10 02:49:57.181124Z] Finished populate-webroot step (success) 18:49:57 INFO - [mozharness: 2016-11-10 02:49:57.181262Z] Running create-virtualenv step. 18:49:57 INFO - Running pre-action listener: _resource_record_pre_action 18:49:57 INFO - Running main action method: create_virtualenv 18:49:57 INFO - Creating virtualenv /builds/slave/test/build/venv 18:49:57 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 18:49:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:49:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:49:57 INFO - Using real prefix '/tools/python27' 18:49:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:49:58 INFO - Installing distribute.............................................................................................................................................................................................done. 18:50:01 INFO - Installing pip.................done. 18:50:01 INFO - Return code: 0 18:50:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:01 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 0x10701e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ecac84250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, '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.H32j4zdBjG/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.Ql8ckatUZk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:50:01 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 18:50:01 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 18:50:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:50:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:01 INFO - 'HOME': '/Users/cltbld', 18:50:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:01 INFO - 'LOGNAME': 'cltbld', 18:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:01 INFO - 'MOZ_NO_REMOTE': '1', 18:50:01 INFO - 'NO_EM_RESTART': '1', 18:50:01 INFO - 'PAGER': '/bin/cat', 18:50:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:01 INFO - 'PWD': '/builds/slave/test', 18:50:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:01 INFO - 'SHELL': '/bin/bash', 18:50:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:50:01 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:50:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:01 INFO - 'USER': 'cltbld', 18:50:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:01 INFO - 'XPC_FLAGS': '0x0', 18:50:01 INFO - 'XPC_SERVICE_NAME': '0', 18:50:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:01 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 18:50:01 INFO - Cleaning up... 18:50:01 INFO - Return code: 0 18:50:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:01 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 0x10701e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ecac84250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, '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.H32j4zdBjG/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.Ql8ckatUZk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:50:01 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 18:50:01 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 18:50:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:50:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:01 INFO - 'HOME': '/Users/cltbld', 18:50:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:01 INFO - 'LOGNAME': 'cltbld', 18:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:01 INFO - 'MOZ_NO_REMOTE': '1', 18:50:01 INFO - 'NO_EM_RESTART': '1', 18:50:01 INFO - 'PAGER': '/bin/cat', 18:50:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:01 INFO - 'PWD': '/builds/slave/test', 18:50:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:01 INFO - 'SHELL': '/bin/bash', 18:50:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:50:01 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:50:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:01 INFO - 'USER': 'cltbld', 18:50:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:01 INFO - 'XPC_FLAGS': '0x0', 18:50:01 INFO - 'XPC_SERVICE_NAME': '0', 18:50:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:01 INFO - Downloading/unpacking psutil>=3.1.1 18:50:01 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 18:50:01 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 18:50:01 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 18:50:01 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 18:50:01 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 18:50:01 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 18:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:50:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:05 INFO - Installing collected packages: psutil 18:50:05 INFO - Running setup.py install for psutil 18:50:05 INFO - building 'psutil._psutil_osx' extension 18:50:05 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 18:50:06 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 18:50:06 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 18:50:06 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 18:50:06 INFO - building 'psutil._psutil_posix' extension 18:50:06 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 18:50:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:50:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:50:06 INFO - ^ 18:50:06 INFO - 1 warning generated. 18:50:06 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 18:50:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:06 INFO - Successfully installed psutil 18:50:06 INFO - Cleaning up... 18:50:06 INFO - Return code: 0 18:50:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:06 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 0x10701e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ecac84250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, '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.H32j4zdBjG/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.Ql8ckatUZk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:50:06 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 18:50:06 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 18:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:06 INFO - 'HOME': '/Users/cltbld', 18:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:06 INFO - 'LOGNAME': 'cltbld', 18:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:06 INFO - 'MOZ_NO_REMOTE': '1', 18:50:06 INFO - 'NO_EM_RESTART': '1', 18:50:06 INFO - 'PAGER': '/bin/cat', 18:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:06 INFO - 'PWD': '/builds/slave/test', 18:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:06 INFO - 'SHELL': '/bin/bash', 18:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:50:06 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:06 INFO - 'USER': 'cltbld', 18:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:06 INFO - 'XPC_FLAGS': '0x0', 18:50:06 INFO - 'XPC_SERVICE_NAME': '0', 18:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:50:06 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 18:50:06 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 18:50:06 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 18:50:06 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 18:50:06 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 18:50:06 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 18:50:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:50:09 INFO - Installing collected packages: mozsystemmonitor 18:50:09 INFO - Running setup.py install for mozsystemmonitor 18:50:09 INFO - Successfully installed mozsystemmonitor 18:50:09 INFO - Cleaning up... 18:50:09 INFO - Return code: 0 18:50:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:09 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 0x10701e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ecac84250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, '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.H32j4zdBjG/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.Ql8ckatUZk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:50:09 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 18:50:09 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 18:50:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:50:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:09 INFO - 'HOME': '/Users/cltbld', 18:50:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:09 INFO - 'LOGNAME': 'cltbld', 18:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:09 INFO - 'MOZ_NO_REMOTE': '1', 18:50:09 INFO - 'NO_EM_RESTART': '1', 18:50:09 INFO - 'PAGER': '/bin/cat', 18:50:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:09 INFO - 'PWD': '/builds/slave/test', 18:50:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:09 INFO - 'SHELL': '/bin/bash', 18:50:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:50:09 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:50:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:09 INFO - 'USER': 'cltbld', 18:50:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:09 INFO - 'XPC_FLAGS': '0x0', 18:50:09 INFO - 'XPC_SERVICE_NAME': '0', 18:50:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:10 INFO - Downloading/unpacking jsonschema==2.5.1 18:50:10 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 18:50:10 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 18:50:10 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 18:50:10 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 18:50:10 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 18:50:10 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 18:50:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:50:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:50:12 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 18:50:12 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 18:50:12 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 18:50:12 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 18:50:12 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 18:50:12 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 18:50:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:50:13 INFO - warning: no files found matching '*.txt' 18:50:13 INFO - no previously-included directories found matching 'build' 18:50:13 INFO - no previously-included directories found matching 'dist' 18:50:13 INFO - no previously-included directories found matching '.git*' 18:50:13 INFO - Installing collected packages: jsonschema, functools32 18:50:13 INFO - Running setup.py install for functools32 18:50:13 INFO - warning: no files found matching '*.txt' 18:50:13 INFO - no previously-included directories found matching 'build' 18:50:13 INFO - no previously-included directories found matching 'dist' 18:50:13 INFO - no previously-included directories found matching '.git*' 18:50:13 INFO - Successfully installed jsonschema functools32 18:50:13 INFO - Cleaning up... 18:50:13 INFO - Return code: 0 18:50:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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')]} 18:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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', '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 0x10701e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ecac84250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, '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.H32j4zdBjG/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.Ql8ckatUZk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:50: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:50: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 functools32==3.2.3-2 18:50:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:50:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:13 INFO - 'HOME': '/Users/cltbld', 18:50:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:13 INFO - 'LOGNAME': 'cltbld', 18:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:13 INFO - 'MOZ_NO_REMOTE': '1', 18:50:13 INFO - 'NO_EM_RESTART': '1', 18:50:13 INFO - 'PAGER': '/bin/cat', 18:50:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:13 INFO - 'PWD': '/builds/slave/test', 18:50:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:13 INFO - 'SHELL': '/bin/bash', 18:50:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:50:13 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:50:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:13 INFO - 'USER': 'cltbld', 18:50:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:13 INFO - 'XPC_FLAGS': '0x0', 18:50:13 INFO - 'XPC_SERVICE_NAME': '0', 18:50:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:50:13 INFO - Cleaning up... 18:50:13 INFO - Return code: 0 18:50:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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')]} 18:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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', '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 0x10701e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ecac84250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, '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.H32j4zdBjG/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.Ql8ckatUZk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:50: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:50: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 blobuploader==1.2.4 18:50:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:50:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:13 INFO - 'HOME': '/Users/cltbld', 18:50:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:13 INFO - 'LOGNAME': 'cltbld', 18:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:13 INFO - 'MOZ_NO_REMOTE': '1', 18:50:13 INFO - 'NO_EM_RESTART': '1', 18:50:13 INFO - 'PAGER': '/bin/cat', 18:50:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:13 INFO - 'PWD': '/builds/slave/test', 18:50:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:13 INFO - 'SHELL': '/bin/bash', 18:50:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:50:13 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:50:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:13 INFO - 'USER': 'cltbld', 18:50:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:13 INFO - 'XPC_FLAGS': '0x0', 18:50:13 INFO - 'XPC_SERVICE_NAME': '0', 18:50:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:14 INFO - Downloading/unpacking blobuploader==1.2.4 18:50: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 18:50: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 18:50: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 18:50: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 18:50: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 18:50: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 18:50:16 INFO - Downloading blobuploader-1.2.4.tar.gz 18:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:50:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:50:16 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 18:50:16 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 18:50:16 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 18:50:16 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 18:50:16 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 18:50:16 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 18:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:50:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:50: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 18:50: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 18:50: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 18:50: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 18:50: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 18:50: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 18:50:17 INFO - Downloading docopt-0.6.1.tar.gz 18:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:50:18 INFO - Installing collected packages: blobuploader, requests, docopt 18:50:18 INFO - Running setup.py install for blobuploader 18:50:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:50:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:50:18 INFO - Running setup.py install for requests 18:50:18 INFO - Running setup.py install for docopt 18:50:18 INFO - Successfully installed blobuploader requests docopt 18:50:18 INFO - Cleaning up... 18:50:18 INFO - Return code: 0 18:50:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:18 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 0x10701e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ecac84250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, '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.H32j4zdBjG/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.Ql8ckatUZk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:50:18 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 18:50:18 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 18:50:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:50:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:18 INFO - 'HOME': '/Users/cltbld', 18:50:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:18 INFO - 'LOGNAME': 'cltbld', 18:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:18 INFO - 'MOZ_NO_REMOTE': '1', 18:50:18 INFO - 'NO_EM_RESTART': '1', 18:50:18 INFO - 'PAGER': '/bin/cat', 18:50:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:18 INFO - 'PWD': '/builds/slave/test', 18:50:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:18 INFO - 'SHELL': '/bin/bash', 18:50:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:50:18 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:50:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:18 INFO - 'USER': 'cltbld', 18:50:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:18 INFO - 'XPC_FLAGS': '0x0', 18:50:18 INFO - 'XPC_SERVICE_NAME': '0', 18:50:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-kSYeHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-gpGH5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-_IF9mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-pvp8xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-QYNGpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-yehdrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:19 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Wlx9xT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-tHidxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-viVNhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-tPYRnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-C4G5gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-UoNub7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-fpU5mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-U5Wam3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-EqYDDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-tVioME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:20 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-xnAzsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:50:21 INFO - Running setup.py install for manifestparser 18:50:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:50:21 INFO - Running setup.py install for mozcrash 18:50:21 INFO - Running setup.py install for mozdebug 18:50:21 INFO - Running setup.py install for mozdevice 18:50:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:50:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:50:21 INFO - Running setup.py install for mozfile 18:50:21 INFO - Running setup.py install for mozhttpd 18:50:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:50:22 INFO - Running setup.py install for mozinfo 18:50:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:50:22 INFO - Running setup.py install for mozInstall 18:50:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:50:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:50:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:50:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:50:22 INFO - Running setup.py install for mozleak 18:50:22 INFO - Running setup.py install for mozlog 18:50:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:50:22 INFO - Running setup.py install for moznetwork 18:50:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:50:22 INFO - Running setup.py install for mozprocess 18:50:22 INFO - Running setup.py install for mozprofile 18:50:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:50:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:50:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:50:23 INFO - Running setup.py install for mozrunner 18:50:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:50:23 INFO - Running setup.py install for mozscreenshot 18:50:23 INFO - Running setup.py install for moztest 18:50:23 INFO - Running setup.py install for mozversion 18:50:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:50:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:50:23 INFO - Cleaning up... 18:50:23 INFO - Return code: 0 18:50:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:23 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 0x10701e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ecac84250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, '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.H32j4zdBjG/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.Ql8ckatUZk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:50:23 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 18:50:23 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 18:50:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:50:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:23 INFO - 'HOME': '/Users/cltbld', 18:50:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:23 INFO - 'LOGNAME': 'cltbld', 18:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:23 INFO - 'MOZ_NO_REMOTE': '1', 18:50:23 INFO - 'NO_EM_RESTART': '1', 18:50:23 INFO - 'PAGER': '/bin/cat', 18:50:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:23 INFO - 'PWD': '/builds/slave/test', 18:50:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:23 INFO - 'SHELL': '/bin/bash', 18:50:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:50:23 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:50:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:23 INFO - 'USER': 'cltbld', 18:50:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:23 INFO - 'XPC_FLAGS': '0x0', 18:50:23 INFO - 'XPC_SERVICE_NAME': '0', 18:50:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-C7aLbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:24 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)) 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-4vzRBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-JvhmGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:24 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)) 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-2g_C48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:24 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)) 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-HEUuNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:24 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)) 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-rb2XEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:24 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)) 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-bEEXou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:24 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)) 18:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:24 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-wfCn2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:25 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)) 18:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-8o4HMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:25 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)) 18:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-s6Ckmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:25 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)) 18:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-9rgV5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:25 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)) 18:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-N504kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:25 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)) 18:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-GuCpbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:25 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)) 18:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-hc4xXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-edfqfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:25 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)) 18:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-JhYVWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:25 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-TEJXqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:26 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)) 18:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:50:26 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)) 18:50:26 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)) 18:50:26 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)) 18:50:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:50:26 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 18:50:26 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 18:50:26 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 18:50:26 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 18:50:26 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 18:50:26 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 18:50:28 INFO - Downloading blessings-1.6.tar.gz 18:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:50:28 INFO - Installing collected packages: blessings 18:50:28 INFO - Running setup.py install for blessings 18:50:28 INFO - Successfully installed blessings 18:50:28 INFO - Cleaning up... 18:50:29 INFO - Return code: 0 18:50:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:29 INFO - Reading from file tmpfile_stdout 18:50:29 INFO - Current package versions: 18:50:29 INFO - blessings == 1.6 18:50:29 INFO - blobuploader == 1.2.4 18:50:29 INFO - docopt == 0.6.1 18:50:29 INFO - functools32 == 3.2.3-2 18:50:29 INFO - jsonschema == 2.5.1 18:50:29 INFO - manifestparser == 1.1 18:50:29 INFO - mozInstall == 1.12 18:50:29 INFO - mozcrash == 0.17 18:50:29 INFO - mozdebug == 0.1 18:50:29 INFO - mozdevice == 0.48 18:50:29 INFO - mozfile == 1.2 18:50:29 INFO - mozhttpd == 0.7 18:50:29 INFO - mozinfo == 0.9 18:50:29 INFO - mozleak == 0.1 18:50:29 INFO - mozlog == 3.4 18:50:29 INFO - moznetwork == 0.27 18:50:29 INFO - mozprocess == 0.23 18:50:29 INFO - mozprofile == 0.28 18:50:29 INFO - mozrunner == 6.12 18:50:29 INFO - mozscreenshot == 0.1 18:50:29 INFO - mozsystemmonitor == 0.3 18:50:29 INFO - moztest == 0.7 18:50:29 INFO - mozversion == 1.4 18:50:29 INFO - psutil == 3.1.1 18:50:29 INFO - requests == 1.2.3 18:50:29 INFO - wsgiref == 0.1.2 18:50:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50:29 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')]} 18:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:29 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')]} 18:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:29 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 0x10701e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ecac84250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, '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.H32j4zdBjG/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.Ql8ckatUZk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:50:29 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 18:50:29 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 18:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:29 INFO - 'HOME': '/Users/cltbld', 18:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:29 INFO - 'LOGNAME': 'cltbld', 18:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:29 INFO - 'MOZ_NO_REMOTE': '1', 18:50:29 INFO - 'NO_EM_RESTART': '1', 18:50:29 INFO - 'PAGER': '/bin/cat', 18:50:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:29 INFO - 'PWD': '/builds/slave/test', 18:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:29 INFO - 'SHELL': '/bin/bash', 18:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:50:29 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:29 INFO - 'USER': 'cltbld', 18:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:29 INFO - 'XPC_FLAGS': '0x0', 18:50:29 INFO - 'XPC_SERVICE_NAME': '0', 18:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 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)) 18:50:29 INFO - Cleaning up... 18:50:29 INFO - Return code: 0 18:50:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:50:29 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')]} 18:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:29 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')]} 18:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:29 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 0x10701e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ecac84250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, '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.H32j4zdBjG/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.Ql8ckatUZk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 18:50:29 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 18:50:29 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 18:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:50:29 INFO - 'HOME': '/Users/cltbld', 18:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:50:29 INFO - 'LOGNAME': 'cltbld', 18:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:29 INFO - 'MOZ_NO_REMOTE': '1', 18:50:29 INFO - 'NO_EM_RESTART': '1', 18:50:29 INFO - 'PAGER': '/bin/cat', 18:50:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:29 INFO - 'PWD': '/builds/slave/test', 18:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:50:29 INFO - 'SHELL': '/bin/bash', 18:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:50:29 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:50:29 INFO - 'USER': 'cltbld', 18:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:29 INFO - 'XPC_FLAGS': '0x0', 18:50:29 INFO - 'XPC_SERVICE_NAME': '0', 18:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:50:29 INFO - Cleaning up... 18:50:29 INFO - Return code: 0 18:50:29 INFO - Running post-action listener: _resource_record_post_action 18:50:29 INFO - Running post-action listener: _start_resource_monitoring 18:50:29 INFO - Starting resource monitoring. 18:50:29 INFO - [mozharness: 2016-11-10 02:50:29.909547Z] Finished create-virtualenv step (success) 18:50:29 INFO - [mozharness: 2016-11-10 02:50:29.910613Z] Running install step. 18:50:29 INFO - Running pre-action listener: _resource_record_pre_action 18:50:29 INFO - Running main action method: install 18:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:30 INFO - Reading from file tmpfile_stdout 18:50:30 INFO - Detecting whether we're running mozinstall >=1.0... 18:50:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:50:30 INFO - Reading from file tmpfile_stdout 18:50:30 INFO - Output received: 18:50:30 INFO - Usage: mozinstall [options] installer 18:50:30 INFO - Options: 18:50:30 INFO - -h, --help show this help message and exit 18:50:30 INFO - -d DEST, --destination=DEST 18:50:30 INFO - Directory to install application into. [default: 18:50:30 INFO - "/builds/slave/test"] 18:50:30 INFO - --app=APP Application being installed. [default: firefox] 18:50:30 INFO - mkdir: /builds/slave/test/build/application 18:50:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:51:04 INFO - Reading from file tmpfile_stdout 18:51:04 INFO - Output received: 18:51:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:51:04 INFO - Running post-action listener: _resource_record_post_action 18:51:04 INFO - [mozharness: 2016-11-10 02:51:04.262904Z] Finished install step (success) 18:51:04 INFO - [mozharness: 2016-11-10 02:51:04.263058Z] Running run-tests step. 18:51:04 INFO - Running pre-action listener: _resource_record_pre_action 18:51:04 INFO - Running main action method: run_tests 18:51:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:51:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:51:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:51:04 INFO - 2016-11-09 18:51:04.278 screenresolution[1649:9042] starting screenresolution argv=screenresolution get 18:51:04 INFO - 2016-11-09 18:51:04.281 screenresolution[1649:9042] Display 0: 1600x1200x32@60 18:51:04 INFO - 2016-11-09 18:51:04.287 screenresolution[1650:9045] starting screenresolution argv=screenresolution list 18:51:04 INFO - Available Modes on Display 0 18:51:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:51:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:51:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:51:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:51:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:51:04 INFO - Intel Iris: 18:51:04 INFO - Chipset Model: Intel Iris 18:51:04 INFO - Type: GPU 18:51:04 INFO - Bus: Built-In 18:51:04 INFO - VRAM (Dynamic, Max): 1536 MB 18:51:04 INFO - Vendor: Intel (0x8086) 18:51:04 INFO - Device ID: 0x0a2e 18:51:04 INFO - Revision ID: 0x0009 18:51:04 INFO - Displays: 18:51:04 INFO - Display: 18:51:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:51:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:51:04 INFO - Display Serial Number: 1600x1200 60 18:51:04 INFO - Main Display: Yes 18:51:04 INFO - Mirror: Off 18:51:04 INFO - Online: Yes 18:51:04 INFO - Rotation: Supported 18:51:04 INFO - Return code: 0 18:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:51:04 INFO - Python 2.7.3 18:51:04 INFO - Return code: 0 18:51:04 INFO - grabbing minidump binary from tooltool 18:51:04 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')]} 18:51:04 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 0x106e32d30>, '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 0x106c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e2ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:51:04 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 18:51:04 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 18:51:04 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 18:51:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:51:04 INFO - Return code: 0 18:51:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:51:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:51:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:51:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:51:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:51:04 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:51:04 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:51:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H32j4zdBjG/Render', 18:51:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:04 INFO - 'HOME': '/Users/cltbld', 18:51:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:04 INFO - 'LOGNAME': 'cltbld', 18:51:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:51:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:04 INFO - 'MOZ_NO_REMOTE': '1', 18:51:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:51:04 INFO - 'NO_EM_RESTART': '1', 18:51:04 INFO - 'PAGER': '/bin/cat', 18:51:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:04 INFO - 'PWD': '/builds/slave/test', 18:51:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:51:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:04 INFO - 'SHELL': '/bin/bash', 18:51:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ql8ckatUZk/Listeners', 18:51:04 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 18:51:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:04 INFO - 'USER': 'cltbld', 18:51:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:04 INFO - 'XPC_FLAGS': '0x0', 18:51:04 INFO - 'XPC_SERVICE_NAME': '0', 18:51:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:51:04 INFO - mozversion application_buildid: 20161109173721 18:51:04 INFO - mozversion application_changeset: 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 18:51:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:51:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:51:04 INFO - mozversion application_name: Firefox 18:51:04 INFO - mozversion application_remotingname: firefox-dev 18:51:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:51:04 INFO - mozversion application_vendor: Mozilla 18:51:04 INFO - mozversion application_version: 51.0a2 18:51:04 INFO - mozversion platform_buildid: 20161109173721 18:51:04 INFO - mozversion platform_changeset: 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 18:51:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:51:04 INFO - mozversion platform_version: 51.0a2 18:51:04 INFO - using testdate: 1478746264 18:51:04 INFO - actual date: 1478746264 18:51:04 INFO - starting webserver on 'localhost:49273' 18:51:04 INFO - SUITE-START | Running 2 tests 18:51:04 INFO - TEST-START | dromaeo_css 18:51:04 INFO - operating with platform_type : mac_ 18:51:04 INFO - Initialising browser for dromaeo_css test... 18:51:04 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpV3tX0p/profile http://localhost:49273/getInfo.html) 18:51:08 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 18:51:08 INFO - PROCESS | 1660 | colorDepth:24 18:51:08 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 18:51:08 INFO - PROCESS | 1660 | __metrics 18:51:08 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 18:51:08 INFO - TEST-INFO | 1660: exit 0 18:51:08 INFO - Browser initialized. 18:51:08 INFO - Running cycle 1/1 for dromaeo_css test... 18:51:08 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpV3tX0p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:21 INFO - PROCESS | 1664 | RSS: Main: 225845248 18:51:21 INFO - PROCESS | 1664 | 18:52:10 INFO - PROCESS | 1664 | 1478746330746 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:54:21 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 18:54:23 INFO - PROCESS | 1664 | RSS: Main: 236388352 18:54:23 INFO - PROCESS | 1664 | 18:57:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 18:57:26 INFO - PROCESS | 1664 | RSS: Main: 247021568 18:57:26 INFO - PROCESS | 1664 | 19:00:28 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 19:00:28 INFO - PROCESS | 1664 | RSS: Main: 250036224 19:00:28 INFO - PROCESS | 1664 | 19:03:30 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 19:03:31 INFO - PROCESS | 1664 | RSS: Main: 251891712 19:03:31 INFO - PROCESS | 1664 | 19:06:33 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 19:06:34 INFO - PROCESS | 1664 | RSS: Main: 256438272 19:06:34 INFO - PROCESS | 1664 | 19:09:37 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 19:09:37 INFO - PROCESS | 1664 | RSS: Main: 259006464 19:09:37 INFO - PROCESS | 1664 | 19:09:37 INFO - PROCESS | 1664 | __start_tp_report 19:09:37 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 19:09:37 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 19:09:37 INFO - PROCESS | 1664 | |i|pagename|runs| 19:09:37 INFO - PROCESS | 1664 | |0;dojo.html;2879.150650558085;2901.7388435040843;2943.3230357017896;2953.8670759815805;2964.4960356739366;4897.485763994779;4989.775460104295;4993;5044.545990860822;5046.192609182532;4956.983818317245;4991;5003.374578177728;5012.248162775585;5040.067587496315;4510.210713125198;4619.514950930155;4627.329037289591;4644.071185762844;4669.2062349400685;3645.2527231917525;4621.907561848761;4680.485146633868;4682.0635872825405;4737.668363214576;3388.847501862422;4022.034711669193;4628.722276663411;4630.768461576925;4688.5077066908;4594.989102397467;4618.1918164321105;4635.374224479686;4645.512221216757;4656.254999200111;4541.159885421208;4569.9314510282375;4573.794179261941;4600.079984003212;4629.0279041401345;4803.159447096744;4959.355283813117;5004.124278251292;5008.84973450797;5039.395272567279;5297.735113244323;5473.562115030788;5486.286782718221;5513.3108361454815;5554;5422.2951016368015;5442.673439593637;5568.9443105568835;5679.148127780824;5722.484976352107;3754.1928485375774;4539.500654927955;5248.448912864094;5259.184826351921;5313.734313284321;5700.97149514258;5703.344115426779;5705.857353566111;5719.599628025998;5721.199032135504;5200.583953283728;5239.161734122522;5442.156465747816;5462.562994960394;5478.178273259043;5456.836294911159;5487.478689524489;5512.6968016759465;5560.805371811967;5642.492175704124;5468.589855760833;5536.612437129363;5543.52880005204;5550.639208451437;5558.055130627722;5393.379761327419;5542.224088627595;5549.445055494418;5564.415736347706;5564.554835613222;4352.695311328177;4357.368181613711;4413.713108647928;4435.401220835146;4540.818367265272;3440.6043305019743;3830.2531006453473;3923.352646813301;3936.7834769087403;3963.009247688078;4988.077205716954;5101.311322971425;5125.538701516807;5130.8973820524125;5140.742962851842;5384.892302153935;5389.326334208224;5447.291852059287;5514.503694667499;5521.757604539027;4017.31705610047;5043.899122017612;5098.388193416814;5110.565601923878;5154.819581314636;4757.738324392122;4777.713337199779;4810.278458231293;4813.253945638432;4821.855344339676;5625.015622266169;5763.9135412968835;5799.072148456226;5855.151003104441;5903.730697899972;5628.183913332462;5667.348254950569;5675.035244008611;5693.658380497183;5703.5722320826935;5572.972135139298;5823.4467725566;5827.125931110368;5831.008728516247;5834.679092649945;5340.946590534045;5368.785248590013;5385.946140538545;5411.512963833274;5507.614466987273;4445.777711114496;5653.858653533694;5680.545556355564;5700.971495142664;5714.942850571608;5392.514673679388;5418.756155973069;5448.891022179613;5453.836384908459;5523.061079616556;4870.634702397264;4894.216925291937;5196.948030519647;5280.075986702389;5375.19372094189;4275.593818587229;4447.688661793643;5190.091733946469;5200.297959775533;5286.788528458818;5391.379991301051;5432.918506222489;5468.125099983983;5485.314335708036;5521.420250873601;5151.768170432414;5196.324477818011;5230.607704422259;5237.188235823453;5310.707911064774 19:09:37 INFO - PROCESS | 1664 | |1;ext.html;424.7960978730209;466.2446836125477;474.62978876476336;477.95937345325643;485.63819954134175;38830.61169388309;40811;40977;41091.38362924551;41120.58879411205;41994.79002604983;42689.57310426895;42846.357304640456;42915.57084429155;42938.355924661155;9364.484953327565;9649.372790768613;9657.903420965806;9695.563699633498;9700.951495242514;9492.857607135898;9603.4718090505;9614.855777163348;9634.181094606967;9641.276904232176;8125.5530945797955;9598.80802383952;9667.70996870095;9689.27330450219;9699.369540979813;9594.184494317991;9632.229421646252;9634.42193468387;9636.90363096367;9680.080392362714;9526.380785248937;9643.228541716717;9648.421094734338;9657.179139773129;9674;39715.60284397177;40232.994175145854;40245.19509609821;40264.396034059515;40269.79865100685;3237.465818140004;3255.951160732591;3372.140104273419;3490.162361033359;3767;28951.986680466292;29313;29968;31300;31718.524222136686;3104.4101620691995;3114.532820076984;3143.3713257348622;3194.7763656544053;3236.0453666168537;499155.50422247656;506850;507905;508820;509046.9999999963;29006.12981610555;29452.55821162684;29494;59410.70294648586;59668.40331596629;34082;34298.65701343004;34507.482387764205;34608;34646.30707385889;14772.704545909022;14949.252537373088;14955.102693838404;14962.251887405586;14981;12591.433385497674;12694.42875070624;12717;12736.108472406842;12777.16948398351;7496.362809161174;7532.849343013109;7535.962320188364;7579.204183560757;7615.961920190363;3096.7987080839675;3153.716165545066;3153.7792354535422;3157.9684203157676;3180.4434224010706;707.844274259662;756.2701992577189;780.5667854340895;905.4250550900226;935.9438433694;24804.255872323858;26522.602160967603;27216.727832721816;29450;29790.25524361908;743.5315751076787;869.899961504435;979.3291595257272;1038.8441733739849;1059.9417032063157;15091.24543772807;15117.697646047018;15135;15173.848261517243;15523.844761552466;663063;664088;678293;678345;679663;57547.712261439265;57612.71193644005;57907.42092579105;57982.130268046014;58094.4190558089;1104.779044191165;1232.4022848918446;1265.4558539827779;1285.8199852020725;1299.4607237996315;27875.44249115047;28114.71885281121;28395.574066388606;28825.711742882304;29234.269143271587;48268.7586562065;48572.757136214095;49197.26204107013;49229.76925576889;49258.75370623124;593389;597679;598220;599710;601698;25616.743832561435;25705.971761130095;25940.8702956484;25947.610785838606;26012.73987260179;45245.54754452545;46034.539654603024;46141.53858461372;47010;47048.764756176;36836.63163368332;37321.50713971519;38930;39939.60060399359;41081.79459102685;38100.237995240495;38152.61847381491;38203.898785567064;39207.41188882226;39469.40795888122;33115.668843312225;33907;34985.77549785745;37724.43413348747;37794.24411511809;31342;33681.15797105092;34192.65807341895;34212.31575368429;34293.142671433416;24356.75643243545;25373.873130634227;25471.70754632092;25629.231123066336;25769.484610308064 19:09:37 INFO - PROCESS | 1664 | |2;jquery.html;267.6694282561037;294.46995408265144;316.3483224557412;341.2254183004579;366.46313151233437;13679.384427700752;14638.48765293215;19253.326133585328;20373.185072597116;20709.68935465969;17514.686398520098;18110.637787244246;19420;19673;19680.91754953477;4974.403071631409;5632.493075623193;5874.588778785486;5940.97029514854;5948.791792287271;3948.526176858781;5020.97489512552;5768.682722450264;5855.209546711203;6035.426634469741;6437.5815571987905;6584.341565843425;6596.736130554772;6603.867922641544;6607.372299631551;6304.464120549759;6473.967630161843;6541.836454088686;6556.737730490775;6581.078648989145;5374.650647707926;5666.405027472098;5667.093265077568;5688.658680479184;5699.2590963174935;24521.264362069167;24586.877065614735;24753.5049299013;24986.375340616447;24988.875500602335;2220.4226901005854;2268.432891777056;2356.8821558921986;2384.9523009539885;2761.4615150045747;12398.760123987618;14300.713985720227;14836;15265.313060912285;15529.990550614173;1726.240454200148;1831.2125785912053;1833.2575307000686;1846.6029803592157;1858.2938483376365;125034;125754.37122814327;126901;129614.7038529612;130025.34987325098;10939.56241750321;11023.944880275547;11220.495077721522;11250.887491125148;11397.658070257905;13647.727045459034;13889.583312500641;13971.231582263074;14005.66946140115;14014.229217392938;6928.852055862699;7289.781306560812;7564.205758395399;7811.453198276066;8366.163383661707;8486.915130848613;8511.489310641382;8522.48865068098;8653.437526560754;8665.783355416164;4269.957300427018;4335.523092459827;4340.782960851945;4426.9778651106535;4427.424434823452;1524.329295110148;1628.7312593421952;1835.6879330513846;1892.867499275065;1902.6384986852454;743.3087228877196;747.3460721868365;762.1007211490383;840.6469282901196;859.8366310401004;19280.035998200034;19916.302929397403;20106.798932010784;20281.391558253275;20370.083346249456;729.9671514781847;795.2445177081795;817.3338728936017;897.3897749530252;897.5736525150501;10403.84394234087;10649;10680.98530639588;10712.035916767529;10715;461921;534495;544163;548098;588445;119196.40401797935;126636;128262;134717;137086;874.8119154381711;885.3581153663542;901.1169054326797;901.5627420700955;902.8239493298744;17698.203580838635;17739.29042838272;18152.001639909933;18261.54346141357;18353.357632483334;40865.79567102146;53847.73076134594;55139.17291240554;55595.44404555903;56141.43858561362;54030.729846350514;54309;74127.21664225179;76319;80608.59695701484;5782.363939966516;6039.667818270037;6819.420349270367;6956.617386043817;7185.964070179615;9660.806783864144;9814.55834487464;12047.879521204675;12222.20555663879;12478;8818.162274583905;10285.845712314172;10505.737356566147;10822.350658960488;10927.945360273148;10510.894891050992;10544.89455105439;10584.841227381441;10590.152787776806;10611.575536978435;8514.659413623385;10728.946355268174;10829.729256768644;10883.455827208449;11052.171087168334;6674.16572928384;6918.100646915868;7298.197198308288;7304.75819110763;7864.6854125834325;6818.897716534355;9380;10642.361458312525;10847.860974597554;10879.836802448128 19:09:37 INFO - PROCESS | 1664 | |3;mootools.html;1240.9689757756057;1423.3381477612909;1426.8430472648013;1528.2740698168373;1603.7273663477208;7815.218478152182;8115.91884081159;8306.958465207674;8949.821003579933;8961.193492585666;8153.796155096125;8636.697715579956;8645.56772161391;8720.258778003861;8770.868436973451;2263.343630347197;2270.3642979965634;2271.965920511194;2282.988585057072;2284.23478134825;2266.829987750917;2279.939827979989;2318.8956496957594;2319.141917490531;2327.895244713992;2281.498070424504;2299.9770002300015;2302.7697230277004;2316.212487754172;2319.46652269978;2204.548067646129;2259.8531095478743;2269.307861102363;2279.0883646541515;2287.1880482428746;1735.3232239426634;2068.855180137391;2254.8534345267503;2270.182734215681;2288.5766133265233;8416.326693864476;8681.956590217009;8734.563271836383;8797.472151670856;8824.779380515474;5123.129068058439;5298.523132918017;5304.708241046741;5305.549028332596;5317.627766056377;3184.9203769905707;3198.9200269993435;3240.578724765789;3250.1874531367157;3266.673332666738;997.4065431068502;1007.5365331947313;1013.083159740436;1031.0359813574332;1036.5024788101678;10424.478776061167;11415.42922853854;11511.539538418454;11530.250533715365;11532.308061516336;4491.528389519119;4493.213687604656;4681.9297710534365;4707.741074240881;4711.764411779397;9723.951380243054;9836.458994755214;9845.310828241954;9873.506324683736;10005.699829005142;4510.548945105464;5191.065608190562;5201.45384734605;5213.087709650796;5236.214567814782;4652.837150699709;4727.267273572602;4736.171170045297;4773.212419950669;4776.880577985578;3871.9806400967814;3892.1826416452864;3905.1018265799025;3948.9732669506134;3956.149427873021;1217.2088142707312;1223.9143259971715;1229.997551995121;1242.453320538978;1250.693580072888;784.3803395317749;786.7875673568219;806.3589446390134;815.4577206157957;819.4591569564059;5683.829485115453;5685.857853553694;5829.533637309005;5851.882962340729;5909.556783241274;398.67507980995396;398.7527732805621;405.92896243157327;840.6469282901196;914.5427286356821;3751;3812.199438118026;3909.7654140751647;3987.521497420328;3993.820278087435;9982;10277.640282590073;10549.947250263853;10556;10708.250422470508;10621.946890265499;10623.52194151265;10624.468776561142;10630.936906309307;10662;7706.460547761603;7871.567063811431;7873.842523149505;7917.841643167105;7932.444728868923;5504.80733174337;5753.8561535961935;5786.913196302143;5924.911126333022;6072.603301240651;9700.708978730649;9847.064528869745;9992.950035249778;10012.799744004933;10041.799164016533;8235.423520353517;8900.243479304332;10037.44794036335;10074.395536267848;10225.92627774073;7116.395106416013;7439.888401674088;7447.776566703008;7494.98817659609;7573.545587264782;8314.08545060055;8419.789505262417;8422.6209820557;8426.03100643434;8441.83116337682;7323.414126869731;7410.592417417094;7464.477486575887;7528.247175282428;7578.772636820904;7234.16807067194;7250.238724933806;7313.48805583604;7425.405967522694;7457.291557302047;6820.965895170492;6975.79072627822;6983.615901125487;6985.650717464208;6998.895016574654;4881.075901921756;4931.235658472942;4995.325631039763;5011.599072074152;5037.823676171316;4181.372794080912;4241.6606671466825;4891.5353041461;5008.9499105009945;5070.112730272262 19:09:37 INFO - PROCESS | 1664 | |4;prototype.html;238.3124685282959;270.1261419308535;273.2839959306617;279.1332911310381;281.77598808946885;3448.8275586220684;3506.9123271918215;3999.8800035998893;4216.6898984297295;4238.4066230727685;3689.8708545200925;3763.266163098197;3883.398073298636;3994.1412596291793;4034.4150098235737;3274.6234183068955;3308.3217940322297;3310;3313.3207692423116;3314.2542927841164;2831.1223520708645;3301.7688761786685;3311.7019468247854;3313.867445302185;3321.618013928393;2669.4927963686932;3083.456148677339;3146.9527957080663;3278.606567211938;3320.4189266878197;3068.463018971693;3273.558069660601;3276.2300859298048;3277.3281477297337;3285.4743241081433;2484.416162201881;2597.4805038992276;2710.566309390488;2869.856507174633;2895.102518219359;3383.813890236036;3703.981480092609;3929.1945151243926;3936.8031598419966;3943.861964831217;3610.526789149441;3735.477033215352;3736.8692095776787;3743.1097295865416;3788.522476234243;3251.64231934487;4371.16947779924;4446.55534446556;4456.665750068758;4459.44256967879;2636.5517861963513;3062.493445005456;3178.5855294393773;3191.4255434021866;3211.9561142628504;4639.512851150648;4665.127943806666;4666.253399456071;4681.46163191234;4705.4588722296685;3101.286704058079;3230.3377807549396;3232.563603913489;3232.8383580820864;3251.2847173621767;3237.7409807215367;3243.1243564237525;3255.6581558936446;3257.03917344384;3275.6396796352383;3187.7449804015623;3575;3718;3733.6453036961443;3736.8878933632036;3674.375356189454;3840.0591854995146;4326.6754993375625;4399.274119770266;4467.776611169494;927.6335847340263;1016.8611155505881;1022.2026819081128;1111.6553868300853;1135.3698697223122;578.9739461724232;685.6400389795398;711.3668834737089;713.4292565947221;727.799131433129;3402.1082080231604;3421.775845700265;3482.7710265430146;3494.4408894576745;3505.158761897126;3322.8827605487277;3567.840451853158;3707.8516859325864;3815.2911432882966;3883.66988805949;3094.5977022986867;3490.2844916792506;3507.31607336572;3511.438169892805;3514.701250393694;1596.1460618569242;1726.9740953885703;1839.59528903641;1855.639976621848;2035.2266138867135;3211.550382946389;3755.849766009329;3756.5116534850295;3874.380099184117;3989.202159568098;3554.8717128926896;3901.5903330150495;3970.3448930926074;3974.8274259093637;3988.3818008208773;3309.7848639838335;3610.8555657773395;3978.781167035841;3983.900402489961;3985.3623420253202;2745.409736906575;3775.565809931893;3787.8484860605267;3812.7331086823656;3819.4097548304503;2963.288810685463;3549.4498352755363;3569.303985722759;3806.6003069677286;3813.6949044075855;3332.7167190789055;3643.2713457309173;3931.567527572022;3955.4178328668763;3992.54085780139;2310.6880571122683;2467.580511313117;2689.3948861506788;2765.14280573023;2865.2550336912136;3351.849166787452;3361.9996102319083;3799.297130030953;4062.7562346258137;4304.880731009897;3698.593154753029;4474.821007159677;4483.506814250364;4495.865124046284;4497.920499080263;3867.723651195155;3891.8637847676328;4196.475440569929;4395.7142785718825;4500.8649740507835;3741.7278125437483;4147.730397524151;4342.109867477223;4397.31841564558;4411.426514553087;4470.597646211857;4487.753173575485;4492.3935268738305;4499.235130027969;4541.159885421208;4349.673774466864;4420.823167073281;4426.358178064227;4432.512423633333;4458.777061146994 19:09:37 INFO - PROCESS | 1664 | |5;yui.html;585.6486108334999;602.4216751918158;621.3010363341241;655.1515787055762;696.7944456385366;11195.664130076091;11622.360770157638;13928.164310141387;14538.055026423275;14549;10524.315919465229;12850.550230741926;12942;12946.223226606387;12966.546170884021;653.7646447278976;678.220046946011;804.8873157757934;809.6518497046268;829.742779738283;835.1523203947967;837.1753822484848;839.6137776622761;841.4446465332882;843.6920524008723;724.4168444402254;883.9116088391173;884.0364003236471;888.5468411110348;889.617464490269;870.7823044238941;873.681106396164;873.8514452543083;874.7419511244167;882.7484167012403;645.2192846655553;652.6214795418646;652.686710379016;653.1998302079961;653.4968074582545;13746;13916.02587818843;13941.721165576631;13943.233122178277;13969.511067112704;12224.938875305656;12425.943794777455;13352.799708004388;13374.39815208318;13518.391672374766;8926.68756593516;10910.727231819188;10934.726631834188;10971.396573188471;11169.273997190157;3400.1159698478327;3443.6039855416698;3445.1903802606366;3468.289000754839;3489.0928358626684;113367;117472.99999999914;118657.62684746257;120701.39649301698;124389;10120.089191972758;10484.842727359095;10532.736681583021;10556.524956376981;10919.235653504178;20709.119949206663;20865.165393384093;20935.895320523603;20949;21165.788342116382;7406.55560666351;7493.437992150611;7500.887486687704;7560.659770310349;7660;4038.3134867072667;4085.080856807195;4111.835526578963;4168.958310416918;4194.916101677949;3292.604887413526;3304.3060957198777;3403.2682973160395;3412.488126781003;3413.5562376890844;585.487698264019;620.5407998081387;628.7767842415968;638.664701031962;643.3373625166087;488.7067759344365;544.5317027356471;545.7516829842413;552.8783667593123;589.4311988930702;8818.86771698425;8987.955060224656;9055.094490551024;9085.409448385833;9162.81674366509;492.0675320268072;503.77581976021054;585.7217821534822;593.9732712027969;600.8793599936175;3659.341318562684;4156.314208155681;4401.449818772653;4532.456105267389;4640.071985602893;125296;140336.8949465759;141515;145191;154668;79322.6033869827;86390.70413943796;107946.84106317986;120787.39606301913;123114.38442807729;72533.91199132123;80849.78725319124;83985.32029359379;100616;107608.38587421195;9457.38526995743;9457.621695132393;9545.474998875128;9578;9582.568784404579;55358.44641553694;59556.40443595508;60000.39999599948;61135;61278.080828788494;79839.60080199562;80271;92563.07436925815;94267.52866235624;97042.5147874256;12154.635360939186;12499.750004999667;12554.372281386077;12622.936885315514;12832.871671283168;13890.236037018061;13892.652683682989;14004.579862604138;14516.20160891119;14550.927245363706;13263.66840828987;13310.86689133135;13482.258475783927;13538.661533461742;13912.373943172784;12123.75752484963;13039.478420863059;13132.606021819362;13193.340332983504;13267.270300133585;10811.513481893491;12968.675783105498;13023.674408139872;13212.207267563977;13631.931840340734;9259.72220833376;9490.240780737662;10764.40795756241;11021.889781102407;11207.551697931991;9849.65526206608;10844.403557804397;10908.400037997986;11080.39057851826;11103.5558577656 19:09:37 INFO - PROCESS | 1664 | __end_tp_report 19:09:37 INFO - PROCESS | 1664 | __start_cc_report 19:09:37 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,374 19:09:37 INFO - PROCESS | 1664 | __end_cc_report 19:09:37 INFO - PROCESS | 1664 | __startTimestamp1478747377442__endTimestamp 19:09:37 INFO - PROCESS | 1664 | 19:09:37 INFO - PROCESS | 1664 | ------- Summary: start ------- 19:09:37 INFO - PROCESS | 1664 | Number of tests: 6 19:09:37 INFO - PROCESS | 1664 | 19:09:37 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5050.38 Median:5200.58 stddev:645.06 (12.4%) stddev-sans-first:624.15 19:09:37 INFO - PROCESS | 1664 | Values: 2879.2 2901.7 2943.3 2953.9 2964.5 4897.5 4989.8 4993.0 5044.5 5046.2 4957.0 4991.0 5003.4 5012.2 5040.1 4510.2 4619.5 4627.3 4644.1 4669.2 3645.3 4621.9 4680.5 4682.1 4737.7 3388.8 4022.0 4628.7 4630.8 4688.5 4595.0 4618.2 4635.4 4645.5 4656.3 4541.2 4569.9 4573.8 4600.1 4629.0 4803.2 4959.4 5004.1 5008.8 5039.4 5297.7 5473.6 5486.3 5513.3 5554.0 5422.3 5442.7 5568.9 5679.1 5722.5 3754.2 4539.5 5248.4 5259.2 5313.7 5701.0 5703.3 5705.9 5719.6 5721.2 5200.6 5239.2 5442.2 5462.6 5478.2 5456.8 5487.5 5512.7 5560.8 5642.5 5468.6 5536.6 5543.5 5550.6 5558.1 5393.4 5542.2 5549.4 5564.4 5564.6 4352.7 4357.4 4413.7 4435.4 4540.8 3440.6 3830.3 3923.4 3936.8 3963.0 4988.1 5101.3 5125.5 5130.9 5140.7 5384.9 5389.3 5447.3 5514.5 5521.8 4017.3 5043.9 5098.4 5110.6 5154.8 4757.7 4777.7 4810.3 4813.3 4821.9 5625.0 5763.9 5799.1 5855.2 5903.7 5628.2 5667.3 5675.0 5693.7 5703.6 5573.0 5823.4 5827.1 5831.0 5834.7 5340.9 5368.8 5385.9 5411.5 5507.6 4445.8 5653.9 5680.5 5701.0 5714.9 5392.5 5418.8 5448.9 5453.8 5523.1 4870.6 4894.2 5196.9 5280.1 5375.2 4275.6 4447.7 5190.1 5200.3 5286.8 5391.4 5432.9 5468.1 5485.3 5521.4 5151.8 5196.3 5230.6 5237.2 5310.7 19:09:37 INFO - PROCESS | 1664 | 19:09:37 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:70133.59 Median:40086.30 stddev:159968.48 (399.1%) stddev-sans-first:160331.61 19:09:37 INFO - PROCESS | 1664 | Values: 424.8 466.2 474.6 478.0 485.6 38830.6 40811.0 40977.0 41091.4 41120.6 41994.8 42689.6 42846.4 42915.6 42938.4 9364.5 9649.4 9657.9 9695.6 9701.0 9492.9 9603.5 9614.9 9634.2 9641.3 8125.6 9598.8 9667.7 9689.3 9699.4 9594.2 9632.2 9634.4 9636.9 9680.1 9526.4 9643.2 9648.4 9657.2 9674.0 39715.6 40233.0 40245.2 40264.4 40269.8 3237.5 3256.0 3372.1 3490.2 3767.0 28952.0 29313.0 29968.0 31300.0 31718.5 3104.4 3114.5 3143.4 3194.8 3236.0 499155.5 506850.0 507905.0 508820.0 509047.0 29006.1 29452.6 29494.0 59410.7 59668.4 34082.0 34298.7 34507.5 34608.0 34646.3 14772.7 14949.3 14955.1 14962.3 14981.0 12591.4 12694.4 12717.0 12736.1 12777.2 7496.4 7532.8 7536.0 7579.2 7616.0 3096.8 3153.7 3153.8 3158.0 3180.4 707.8 756.3 780.6 905.4 935.9 24804.3 26522.6 27216.7 29450.0 29790.3 743.5 869.9 979.3 1038.8 1059.9 15091.2 15117.7 15135.0 15173.8 15523.8 663063.0 664088.0 678293.0 678345.0 679663.0 57547.7 57612.7 57907.4 57982.1 58094.4 1104.8 1232.4 1265.5 1285.8 1299.5 27875.4 28114.7 28395.6 28825.7 29234.3 48268.8 48572.8 49197.3 49229.8 49258.8 593389.0 597679.0 598220.0 599710.0 601698.0 25616.7 25706.0 25940.9 25947.6 26012.7 45245.5 46034.5 46141.5 47010.0 47048.8 36836.6 37321.5 38930.0 39939.6 41081.8 38100.2 38152.6 38203.9 39207.4 39469.4 33115.7 33907.0 34985.8 37724.4 37794.2 31342.0 33681.2 34192.7 34212.3 34293.1 24356.8 25373.9 25471.7 25629.2 25769.5 19:09:37 INFO - PROCESS | 1664 | 19:09:37 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:32967.12 Median:305.41 stddev:90526.29 (29641.0%) stddev-sans-first:90746.94 19:09:37 INFO - PROCESS | 1664 | Values: 267.7 294.5 316.3 341.2 366.5 13679.4 14638.5 19253.3 20373.2 20709.7 17514.7 18110.6 19420.0 19673.0 19680.9 4974.4 5632.5 5874.6 5941.0 5948.8 3948.5 5021.0 5768.7 5855.2 6035.4 6437.6 6584.3 6596.7 6603.9 6607.4 6304.5 6474.0 6541.8 6556.7 6581.1 5374.7 5666.4 5667.1 5688.7 5699.3 24521.3 24586.9 24753.5 24986.4 24988.9 2220.4 2268.4 2356.9 2385.0 2761.5 12398.8 14300.7 14836.0 15265.3 15530.0 1726.2 1831.2 1833.3 1846.6 1858.3 125034.0 125754.4 126901.0 129614.7 130025.3 10939.6 11023.9 11220.5 11250.9 11397.7 13647.7 13889.6 13971.2 14005.7 14014.2 6928.9 7289.8 7564.2 7811.5 8366.2 8486.9 8511.5 8522.5 8653.4 8665.8 4270.0 4335.5 4340.8 4427.0 4427.4 1524.3 1628.7 1835.7 1892.9 1902.6 743.3 747.3 762.1 840.6 859.8 19280.0 19916.3 20106.8 20281.4 20370.1 730.0 795.2 817.3 897.4 897.6 10403.8 10649.0 10681.0 10712.0 10715.0 461921.0 534495.0 544163.0 548098.0 588445.0 119196.4 126636.0 128262.0 134717.0 137086.0 874.8 885.4 901.1 901.6 902.8 17698.2 17739.3 18152.0 18261.5 18353.4 40865.8 53847.7 55139.2 55595.4 56141.4 54030.7 54309.0 74127.2 76319.0 80608.6 5782.4 6039.7 6819.4 6956.6 7186.0 9660.8 9814.6 12047.9 12222.2 12478.0 8818.2 10285.8 10505.7 10822.4 10927.9 10510.9 10544.9 10584.8 10590.2 10611.6 8514.7 10728.9 10829.7 10883.5 11052.2 6674.2 6918.1 7298.2 7304.8 7864.7 6818.9 9380.0 10642.4 10847.9 10879.8 19:09:37 INFO - PROCESS | 1664 | 19:09:37 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5585.18 Median:4886.31 stddev:3178.75 (65.1%) stddev-sans-first:3170.89 19:09:37 INFO - PROCESS | 1664 | Values: 1241.0 1423.3 1426.8 1528.3 1603.7 7815.2 8115.9 8307.0 8949.8 8961.2 8153.8 8636.7 8645.6 8720.3 8770.9 2263.3 2270.4 2272.0 2283.0 2284.2 2266.8 2279.9 2318.9 2319.1 2327.9 2281.5 2300.0 2302.8 2316.2 2319.5 2204.5 2259.9 2269.3 2279.1 2287.2 1735.3 2068.9 2254.9 2270.2 2288.6 8416.3 8682.0 8734.6 8797.5 8824.8 5123.1 5298.5 5304.7 5305.5 5317.6 3184.9 3198.9 3240.6 3250.2 3266.7 997.4 1007.5 1013.1 1031.0 1036.5 10424.5 11415.4 11511.5 11530.3 11532.3 4491.5 4493.2 4681.9 4707.7 4711.8 9724.0 9836.5 9845.3 9873.5 10005.7 4510.5 5191.1 5201.5 5213.1 5236.2 4652.8 4727.3 4736.2 4773.2 4776.9 3872.0 3892.2 3905.1 3949.0 3956.1 1217.2 1223.9 1230.0 1242.5 1250.7 784.4 786.8 806.4 815.5 819.5 5683.8 5685.9 5829.5 5851.9 5909.6 398.7 398.8 405.9 840.6 914.5 3751.0 3812.2 3909.8 3987.5 3993.8 9982.0 10277.6 10549.9 10556.0 10708.3 10621.9 10623.5 10624.5 10630.9 10662.0 7706.5 7871.6 7873.8 7917.8 7932.4 5504.8 5753.9 5786.9 5924.9 6072.6 9700.7 9847.1 9993.0 10012.8 10041.8 8235.4 8900.2 10037.4 10074.4 10225.9 7116.4 7439.9 7447.8 7495.0 7573.5 8314.1 8419.8 8422.6 8426.0 8441.8 7323.4 7410.6 7464.5 7528.2 7578.8 7234.2 7250.2 7313.5 7425.4 7457.3 6821.0 6975.8 6983.6 6985.7 6998.9 4881.1 4931.2 4995.3 5011.6 5037.8 4181.4 4241.7 4891.5 5008.9 5070.1 19:09:37 INFO - PROCESS | 1664 | 19:09:37 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:3377.35 Median:3682.12 stddev:1019.27 (27.7%) stddev-sans-first:994.52 19:09:37 INFO - PROCESS | 1664 | Values: 238.3 270.1 273.3 279.1 281.8 3448.8 3506.9 3999.9 4216.7 4238.4 3689.9 3763.3 3883.4 3994.1 4034.4 3274.6 3308.3 3310.0 3313.3 3314.3 2831.1 3301.8 3311.7 3313.9 3321.6 2669.5 3083.5 3147.0 3278.6 3320.4 3068.5 3273.6 3276.2 3277.3 3285.5 2484.4 2597.5 2710.6 2869.9 2895.1 3383.8 3704.0 3929.2 3936.8 3943.9 3610.5 3735.5 3736.9 3743.1 3788.5 3251.6 4371.2 4446.6 4456.7 4459.4 2636.6 3062.5 3178.6 3191.4 3212.0 4639.5 4665.1 4666.3 4681.5 4705.5 3101.3 3230.3 3232.6 3232.8 3251.3 3237.7 3243.1 3255.7 3257.0 3275.6 3187.7 3575.0 3718.0 3733.6 3736.9 3674.4 3840.1 4326.7 4399.3 4467.8 927.6 1016.9 1022.2 1111.7 1135.4 579.0 685.6 711.4 713.4 727.8 3402.1 3421.8 3482.8 3494.4 3505.2 3322.9 3567.8 3707.9 3815.3 3883.7 3094.6 3490.3 3507.3 3511.4 3514.7 1596.1 1727.0 1839.6 1855.6 2035.2 3211.6 3755.8 3756.5 3874.4 3989.2 3554.9 3901.6 3970.3 3974.8 3988.4 3309.8 3610.9 3978.8 3983.9 3985.4 2745.4 3775.6 3787.8 3812.7 3819.4 2963.3 3549.4 3569.3 3806.6 3813.7 3332.7 3643.3 3931.6 3955.4 3992.5 2310.7 2467.6 2689.4 2765.1 2865.3 3351.8 3362.0 3799.3 4062.8 4304.9 3698.6 4474.8 4483.5 4495.9 4497.9 3867.7 3891.9 4196.5 4395.7 4500.9 3741.7 4147.7 4342.1 4397.3 4411.4 4470.6 4487.8 4492.4 4499.2 4541.2 4349.7 4420.8 4426.4 4432.5 4458.8 19:09:37 INFO - PROCESS | 1664 | 19:09:37 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:23065.10 Median:3574.22 stddev:36787.71 (1029.3%) stddev-sans-first:36852.19 19:09:37 INFO - PROCESS | 1664 | Values: 585.6 602.4 621.3 655.2 696.8 11195.7 11622.4 13928.2 14538.1 14549.0 10524.3 12850.6 12942.0 12946.2 12966.5 653.8 678.2 804.9 809.7 829.7 835.2 837.2 839.6 841.4 843.7 724.4 883.9 884.0 888.5 889.6 870.8 873.7 873.9 874.7 882.7 645.2 652.6 652.7 653.2 653.5 13746.0 13916.0 13941.7 13943.2 13969.5 12224.9 12425.9 13352.8 13374.4 13518.4 8926.7 10910.7 10934.7 10971.4 11169.3 3400.1 3443.6 3445.2 3468.3 3489.1 113367.0 117473.0 118657.6 120701.4 124389.0 10120.1 10484.8 10532.7 10556.5 10919.2 20709.1 20865.2 20935.9 20949.0 21165.8 7406.6 7493.4 7500.9 7560.7 7660.0 4038.3 4085.1 4111.8 4169.0 4194.9 3292.6 3304.3 3403.3 3412.5 3413.6 585.5 620.5 628.8 638.7 643.3 488.7 544.5 545.8 552.9 589.4 8818.9 8988.0 9055.1 9085.4 9162.8 492.1 503.8 585.7 594.0 600.9 3659.3 4156.3 4401.4 4532.5 4640.1 125296.0 140336.9 141515.0 145191.0 154668.0 79322.6 86390.7 107946.8 120787.4 123114.4 72533.9 80849.8 83985.3 100616.0 107608.4 9457.4 9457.6 9545.5 9578.0 9582.6 55358.4 59556.4 60000.4 61135.0 61278.1 79839.6 80271.0 92563.1 94267.5 97042.5 12154.6 12499.8 12554.4 12622.9 12832.9 13890.2 13892.7 14004.6 14516.2 14550.9 13263.7 13310.9 13482.3 13538.7 13912.4 12123.8 13039.5 13132.6 13193.3 13267.3 10811.5 12968.7 13023.7 13212.2 13631.9 9259.7 9490.2 10764.4 11021.9 11207.6 9849.7 10844.4 10908.4 11080.4 11103.6 19:09:37 INFO - PROCESS | 1664 | -------- Summary: end -------- 19:09:37 INFO - PROCESS | 1664 | 19:09:38 INFO - TEST-INFO | 1664: exit 0 19:09:38 INFO - TEST-OK | dromaeo_css | took 1113204ms 19:09:38 INFO - TEST-START | kraken 19:09:38 INFO - operating with platform_type : mac_ 19:09:38 INFO - Initialising browser for kraken test... 19:09:38 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpLzSqVe/profile http://localhost:49273/getInfo.html) 19:09:40 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 19:09:40 INFO - PROCESS | 1673 | colorDepth:24 19:09:40 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 19:09:40 INFO - PROCESS | 1673 | __metrics 19:09:41 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 19:09:41 INFO - TEST-INFO | 1673: exit 0 19:09:41 INFO - Browser initialized. 19:09:41 INFO - Running cycle 1/1 for kraken test... 19:09:41 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpLzSqVe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:53 INFO - PROCESS | 1675 | RSS: Main: 225587200 19:09:53 INFO - PROCESS | 1675 | 19:09:56 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 19:09:57 INFO - PROCESS | 1675 | RSS: Main: 238256128 19:09:57 INFO - PROCESS | 1675 | 19:10:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 19:10:01 INFO - PROCESS | 1675 | RSS: Main: 245841920 19:10:01 INFO - PROCESS | 1675 | 19:10:04 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 19:10:05 INFO - PROCESS | 1675 | RSS: Main: 247631872 19:10:05 INFO - PROCESS | 1675 | 19:10:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 19:10:08 INFO - PROCESS | 1675 | RSS: Main: 249311232 19:10:08 INFO - PROCESS | 1675 | 19:10:10 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:10:10 INFO - PROCESS | 1675 | RSS: Main: 250920960 19:10:10 INFO - PROCESS | 1675 | 19:10:13 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 19:10:14 INFO - PROCESS | 1675 | RSS: Main: 251310080 19:10:14 INFO - PROCESS | 1675 | 19:10:17 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 19:10:18 INFO - PROCESS | 1675 | RSS: Main: 251871232 19:10:18 INFO - PROCESS | 1675 | 19:10:21 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 19:10:22 INFO - PROCESS | 1675 | RSS: Main: 251506688 19:10:22 INFO - PROCESS | 1675 | 19:10:23 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:10:24 INFO - PROCESS | 1675 | RSS: Main: 251375616 19:10:24 INFO - PROCESS | 1675 | 19:10:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:10:26 INFO - PROCESS | 1675 | RSS: Main: 251473920 19:10:26 INFO - PROCESS | 1675 | 19:10:29 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:10:29 INFO - PROCESS | 1675 | RSS: Main: 251502592 19:10:29 INFO - PROCESS | 1675 | 19:10:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:10:33 INFO - PROCESS | 1675 | RSS: Main: 251879424 19:10:33 INFO - PROCESS | 1675 | 19:10:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:10:37 INFO - PROCESS | 1675 | RSS: Main: 251613184 19:10:37 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 19:10:39 INFO - PROCESS | 1675 | RSS: Main: 254521344 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | __start_tp_report 19:10:39 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 19:10:39 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 19:10:39 INFO - PROCESS | 1675 | |i|pagename|runs| 19:10:39 INFO - PROCESS | 1675 | |0;ai-astar;111;122;123;123;122;122;121;128;114;125 19:10:39 INFO - PROCESS | 1675 | |1;audio-beat-detection;151;114;117;167;148;150;125;114;148;118 19:10:39 INFO - PROCESS | 1675 | |2;audio-dft;229;229;224;226;229;230;264;286;223;227 19:10:39 INFO - PROCESS | 1675 | |3;audio-fft;90;61;61;83;69;63;61;54;106;88 19:10:39 INFO - PROCESS | 1675 | |4;audio-oscillator;90;74;90;75;72;76;92;72;84;90 19:10:39 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;95;91;94;92;95;93;133;92;97;120 19:10:39 INFO - PROCESS | 1675 | |6;imaging-darkroom;138;99;99;101;99;123;123;122;101;100 19:10:39 INFO - PROCESS | 1675 | |7;imaging-desaturate;114;123;96;169;122;162;162;106;111;106 19:10:39 INFO - PROCESS | 1675 | |8;json-parse-financial;58;57;57;58;59;66;56;61;61;60 19:10:39 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;77;77;82;82;78;77;76;86;115;114 19:10:39 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;91;97;90;88;89;90;89;93;91;91 19:10:39 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;148;149;159;160;172;148;148;153;177;169 19:10:39 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;225;241;190;173;174;176;175;170;201;245 19:10:39 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;70;72;73;72;71;68;69;71;77;84 19:10:39 INFO - PROCESS | 1675 | __end_tp_report 19:10:39 INFO - PROCESS | 1675 | __start_cc_report 19:10:39 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,987 19:10:39 INFO - PROCESS | 1675 | __end_cc_report 19:10:39 INFO - PROCESS | 1675 | __startTimestamp1478747439478__endTimestamp 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | ------- Summary: start ------- 19:10:39 INFO - PROCESS | 1675 | Number of tests: 14 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:121.10 Median:122.50 stddev:5.00 (4.1%) stddev-sans-first:3.73 19:10:39 INFO - PROCESS | 1675 | Values: 111.0 122.0 123.0 123.0 122.0 122.0 121.0 128.0 114.0 125.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:148.00 stddev:19.54 (13.2%) stddev-sans-first:19.88 19:10:39 INFO - PROCESS | 1675 | Values: 151.0 114.0 117.0 167.0 148.0 150.0 125.0 114.0 148.0 118.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:236.70 Median:229.00 stddev:20.97 (9.2%) stddev-sans-first:22.05 19:10:39 INFO - PROCESS | 1675 | Values: 229.0 229.0 224.0 226.0 229.0 230.0 264.0 286.0 223.0 227.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:73.60 Median:66.00 stddev:17.02 (25.8%) stddev-sans-first:16.99 19:10:39 INFO - PROCESS | 1675 | Values: 90.0 61.0 61.0 83.0 69.0 63.0 61.0 54.0 106.0 88.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:81.50 Median:87.00 stddev:8.45 (9.7%) stddev-sans-first:8.38 19:10:39 INFO - PROCESS | 1675 | Values: 90.0 74.0 90.0 75.0 72.0 76.0 92.0 72.0 84.0 90.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:100.20 Median:93.50 stddev:14.30 (15.3%) stddev-sans-first:15.05 19:10:39 INFO - PROCESS | 1675 | Values: 95.0 91.0 94.0 92.0 95.0 93.0 133.0 92.0 97.0 120.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:110.50 Median:130.50 stddev:14.49 (11.1%) stddev-sans-first:11.45 19:10:39 INFO - PROCESS | 1675 | Values: 138.0 99.0 99.0 101.0 99.0 123.0 123.0 122.0 101.0 100.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:127.10 Median:142.50 stddev:26.92 (18.9%) stddev-sans-first:28.13 19:10:39 INFO - PROCESS | 1675 | Values: 114.0 123.0 96.0 169.0 122.0 162.0 162.0 106.0 111.0 106.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.50 stddev:2.91 (4.9%) stddev-sans-first:3.05 19:10:39 INFO - PROCESS | 1675 | Values: 58.0 57.0 57.0 58.0 59.0 66.0 56.0 61.0 61.0 60.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:86.40 Median:77.50 stddev:15.14 (19.5%) stddev-sans-first:15.67 19:10:39 INFO - PROCESS | 1675 | Values: 77.0 77.0 82.0 82.0 78.0 77.0 76.0 86.0 115.0 114.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:91.00 stddev:2.56 (2.8%) stddev-sans-first:2.71 19:10:39 INFO - PROCESS | 1675 | Values: 91.0 97.0 90.0 88.0 89.0 90.0 89.0 93.0 91.0 91.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:158.30 Median:159.50 stddev:11.00 (6.9%) stddev-sans-first:11.01 19:10:39 INFO - PROCESS | 1675 | Values: 148.0 149.0 159.0 160.0 172.0 148.0 148.0 153.0 177.0 169.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.00 Median:195.50 stddev:29.53 (15.1%) stddev-sans-first:29.53 19:10:39 INFO - PROCESS | 1675 | Values: 225.0 241.0 190.0 173.0 174.0 176.0 175.0 170.0 201.0 245.0 19:10:39 INFO - PROCESS | 1675 | 19:10:39 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:72.00 stddev:4.67 (6.5%) stddev-sans-first:4.85 19:10:39 INFO - PROCESS | 1675 | Values: 70.0 72.0 73.0 72.0 71.0 68.0 69.0 71.0 77.0 84.0 19:10:39 INFO - PROCESS | 1675 | -------- Summary: end -------- 19:10:39 INFO - PROCESS | 1675 | 19:10:40 INFO - TEST-INFO | 1675: exit 0 19:10:40 INFO - TEST-OK | kraken | took 62209ms 19:10:40 INFO - SUITE-END | took 1175s 19:10:40 INFO - Completed test suite (00:19:35) 19:10:40 INFO - javascript benchmark 19:10:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6588.372228305318, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2879.150650558085, 2901.7388435040843, 2943.3230357017896, 2953.8670759815805, 2964.4960356739366, 4897.485763994779, 4989.775460104295, 4993.0, 5044.545990860822, 5046.192609182532, 4956.983818317245, 4991.0, 5003.374578177728, 5012.248162775585, 5040.067587496315, 4510.210713125198, 4619.514950930155, 4627.329037289591, 4644.071185762844, 4669.2062349400685, 3645.2527231917525, 4621.907561848761, 4680.485146633868, 4682.0635872825405, 4737.668363214576, 3388.847501862422, 4022.034711669193, 4628.722276663411, 4630.768461576925, 4688.5077066908, 4594.989102397467, 4618.1918164321105, 4635.374224479686, 4645.512221216757, 4656.254999200111, 4541.159885421208, 4569.9314510282375, 4573.794179261941, 4600.079984003212, 4629.0279041401345, 4803.159447096744, 4959.355283813117, 5004.124278251292, 5008.84973450797, 5039.395272567279, 5297.735113244323, 5473.562115030788, 5486.286782718221, 5513.3108361454815, 5554.0, 5422.2951016368015, 5442.673439593637, 5568.9443105568835, 5679.148127780824, 5722.484976352107, 3754.1928485375774, 4539.500654927955, 5248.448912864094, 5259.184826351921, 5313.734313284321, 5700.97149514258, 5703.344115426779, 5705.857353566111, 5719.599628025998, 5721.199032135504, 5200.583953283728, 5239.161734122522, 5442.156465747816, 5462.562994960394, 5478.178273259043, 5456.836294911159, 5487.478689524489, 5512.6968016759465, 5560.805371811967, 5642.492175704124, 5468.589855760833, 5536.612437129363, 5543.52880005204, 5550.639208451437, 5558.055130627722, 5393.379761327419, 5542.224088627595, 5549.445055494418, 5564.415736347706, 5564.554835613222, 4352.695311328177, 4357.368181613711, 4413.713108647928, 4435.401220835146, 4540.818367265272, 3440.6043305019743, 3830.2531006453473, 3923.352646813301, 3936.7834769087403, 3963.009247688078, 4988.077205716954, 5101.311322971425, 5125.538701516807, 5130.8973820524125, 5140.742962851842, 5384.892302153935, 5389.326334208224, 5447.291852059287, 5514.503694667499, 5521.757604539027, 4017.31705610047, 5043.899122017612, 5098.388193416814, 5110.565601923878, 5154.819581314636, 4757.738324392122, 4777.713337199779, 4810.278458231293, 4813.253945638432, 4821.855344339676, 5625.015622266169, 5763.9135412968835, 5799.072148456226, 5855.151003104441, 5903.730697899972, 5628.183913332462, 5667.348254950569, 5675.035244008611, 5693.658380497183, 5703.5722320826935, 5572.972135139298, 5823.4467725566, 5827.125931110368, 5831.008728516247, 5834.679092649945, 5340.946590534045, 5368.785248590013, 5385.946140538545, 5411.512963833274, 5507.614466987273, 4445.777711114496, 5653.858653533694, 5680.545556355564, 5700.971495142664, 5714.942850571608, 5392.514673679388, 5418.756155973069, 5448.891022179613, 5453.836384908459, 5523.061079616556, 4870.634702397264, 4894.216925291937, 5196.948030519647, 5280.075986702389, 5375.19372094189, 4275.593818587229, 4447.688661793643, 5190.091733946469, 5200.297959775533, 5286.788528458818, 5391.379991301051, 5432.918506222489, 5468.125099983983, 5485.314335708036, 5521.420250873601, 5151.768170432414, 5196.324477818011, 5230.607704422259, 5237.188235823453, 5310.707911064774], "value": 5008.181621521913, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.7960978730209, 466.2446836125477, 474.62978876476336, 477.95937345325643, 485.63819954134175, 38830.61169388309, 40811.0, 40977.0, 41091.38362924551, 41120.58879411205, 41994.79002604983, 42689.57310426895, 42846.357304640456, 42915.57084429155, 42938.355924661155, 9364.484953327565, 9649.372790768613, 9657.903420965806, 9695.563699633498, 9700.951495242514, 9492.857607135898, 9603.4718090505, 9614.855777163348, 9634.181094606967, 9641.276904232176, 8125.5530945797955, 9598.80802383952, 9667.70996870095, 9689.27330450219, 9699.369540979813, 9594.184494317991, 9632.229421646252, 9634.42193468387, 9636.90363096367, 9680.080392362714, 9526.380785248937, 9643.228541716717, 9648.421094734338, 9657.179139773129, 9674.0, 39715.60284397177, 40232.994175145854, 40245.19509609821, 40264.396034059515, 40269.79865100685, 3237.465818140004, 3255.951160732591, 3372.140104273419, 3490.162361033359, 3767.0, 28951.986680466292, 29313.0, 29968.0, 31300.0, 31718.524222136686, 3104.4101620691995, 3114.532820076984, 3143.3713257348622, 3194.7763656544053, 3236.0453666168537, 499155.50422247656, 506850.0, 507905.0, 508820.0, 509046.9999999963, 29006.12981610555, 29452.55821162684, 29494.0, 59410.70294648586, 59668.40331596629, 34082.0, 34298.65701343004, 34507.482387764205, 34608.0, 34646.30707385889, 14772.704545909022, 14949.252537373088, 14955.102693838404, 14962.251887405586, 14981.0, 12591.433385497674, 12694.42875070624, 12717.0, 12736.108472406842, 12777.16948398351, 7496.362809161174, 7532.849343013109, 7535.962320188364, 7579.204183560757, 7615.961920190363, 3096.7987080839675, 3153.716165545066, 3153.7792354535422, 3157.9684203157676, 3180.4434224010706, 707.844274259662, 756.2701992577189, 780.5667854340895, 905.4250550900226, 935.9438433694, 24804.255872323858, 26522.602160967603, 27216.727832721816, 29450.0, 29790.25524361908, 743.5315751076787, 869.899961504435, 979.3291595257272, 1038.8441733739849, 1059.9417032063157, 15091.24543772807, 15117.697646047018, 15135.0, 15173.848261517243, 15523.844761552466, 663063.0, 664088.0, 678293.0, 678345.0, 679663.0, 57547.712261439265, 57612.71193644005, 57907.42092579105, 57982.130268046014, 58094.4190558089, 1104.779044191165, 1232.4022848918446, 1265.4558539827779, 1285.8199852020725, 1299.4607237996315, 27875.44249115047, 28114.71885281121, 28395.574066388606, 28825.711742882304, 29234.269143271587, 48268.7586562065, 48572.757136214095, 49197.26204107013, 49229.76925576889, 49258.75370623124, 593389.0, 597679.0, 598220.0, 599710.0, 601698.0, 25616.743832561435, 25705.971761130095, 25940.8702956484, 25947.610785838606, 26012.73987260179, 45245.54754452545, 46034.539654603024, 46141.53858461372, 47010.0, 47048.764756176, 36836.63163368332, 37321.50713971519, 38930.0, 39939.60060399359, 41081.79459102685, 38100.237995240495, 38152.61847381491, 38203.898785567064, 39207.41188882226, 39469.40795888122, 33115.668843312225, 33907.0, 34985.77549785745, 37724.43413348747, 37794.24411511809, 31342.0, 33681.15797105092, 34192.65807341895, 34212.31575368429, 34293.142671433416, 24356.75643243545, 25373.873130634227, 25471.70754632092, 25629.231123066336, 25769.484610308064], "value": 18112.415785708115, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.6694282561037, 294.46995408265144, 316.3483224557412, 341.2254183004579, 366.46313151233437, 13679.384427700752, 14638.48765293215, 19253.326133585328, 20373.185072597116, 20709.68935465969, 17514.686398520098, 18110.637787244246, 19420.0, 19673.0, 19680.91754953477, 4974.403071631409, 5632.493075623193, 5874.588778785486, 5940.97029514854, 5948.791792287271, 3948.526176858781, 5020.97489512552, 5768.682722450264, 5855.209546711203, 6035.426634469741, 6437.5815571987905, 6584.341565843425, 6596.736130554772, 6603.867922641544, 6607.372299631551, 6304.464120549759, 6473.967630161843, 6541.836454088686, 6556.737730490775, 6581.078648989145, 5374.650647707926, 5666.405027472098, 5667.093265077568, 5688.658680479184, 5699.2590963174935, 24521.264362069167, 24586.877065614735, 24753.5049299013, 24986.375340616447, 24988.875500602335, 2220.4226901005854, 2268.432891777056, 2356.8821558921986, 2384.9523009539885, 2761.4615150045747, 12398.760123987618, 14300.713985720227, 14836.0, 15265.313060912285, 15529.990550614173, 1726.240454200148, 1831.2125785912053, 1833.2575307000686, 1846.6029803592157, 1858.2938483376365, 125034.0, 125754.37122814327, 126901.0, 129614.7038529612, 130025.34987325098, 10939.56241750321, 11023.944880275547, 11220.495077721522, 11250.887491125148, 11397.658070257905, 13647.727045459034, 13889.583312500641, 13971.231582263074, 14005.66946140115, 14014.229217392938, 6928.852055862699, 7289.781306560812, 7564.205758395399, 7811.453198276066, 8366.163383661707, 8486.915130848613, 8511.489310641382, 8522.48865068098, 8653.437526560754, 8665.783355416164, 4269.957300427018, 4335.523092459827, 4340.782960851945, 4426.9778651106535, 4427.424434823452, 1524.329295110148, 1628.7312593421952, 1835.6879330513846, 1892.867499275065, 1902.6384986852454, 743.3087228877196, 747.3460721868365, 762.1007211490383, 840.6469282901196, 859.8366310401004, 19280.035998200034, 19916.302929397403, 20106.798932010784, 20281.391558253275, 20370.083346249456, 729.9671514781847, 795.2445177081795, 817.3338728936017, 897.3897749530252, 897.5736525150501, 10403.84394234087, 10649.0, 10680.98530639588, 10712.035916767529, 10715.0, 461921.0, 534495.0, 544163.0, 548098.0, 588445.0, 119196.40401797935, 126636.0, 128262.0, 134717.0, 137086.0, 874.8119154381711, 885.3581153663542, 901.1169054326797, 901.5627420700955, 902.8239493298744, 17698.203580838635, 17739.29042838272, 18152.001639909933, 18261.54346141357, 18353.357632483334, 40865.79567102146, 53847.73076134594, 55139.17291240554, 55595.44404555903, 56141.43858561362, 54030.729846350514, 54309.0, 74127.21664225179, 76319.0, 80608.59695701484, 5782.363939966516, 6039.667818270037, 6819.420349270367, 6956.617386043817, 7185.964070179615, 9660.806783864144, 9814.55834487464, 12047.879521204675, 12222.20555663879, 12478.0, 8818.162274583905, 10285.845712314172, 10505.737356566147, 10822.350658960488, 10927.945360273148, 10510.894891050992, 10544.89455105439, 10584.841227381441, 10590.152787776806, 10611.575536978435, 8514.659413623385, 10728.946355268174, 10829.729256768644, 10883.455827208449, 11052.171087168334, 6674.16572928384, 6918.100646915868, 7298.197198308288, 7304.75819110763, 7864.6854125834325, 6818.897716534355, 9380.0, 10642.361458312525, 10847.860974597554, 10879.836802448128], "value": 9133.717870449773, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.9689757756057, 1423.3381477612909, 1426.8430472648013, 1528.2740698168373, 1603.7273663477208, 7815.218478152182, 8115.91884081159, 8306.958465207674, 8949.821003579933, 8961.193492585666, 8153.796155096125, 8636.697715579956, 8645.56772161391, 8720.258778003861, 8770.868436973451, 2263.343630347197, 2270.3642979965634, 2271.965920511194, 2282.988585057072, 2284.23478134825, 2266.829987750917, 2279.939827979989, 2318.8956496957594, 2319.141917490531, 2327.895244713992, 2281.498070424504, 2299.9770002300015, 2302.7697230277004, 2316.212487754172, 2319.46652269978, 2204.548067646129, 2259.8531095478743, 2269.307861102363, 2279.0883646541515, 2287.1880482428746, 1735.3232239426634, 2068.855180137391, 2254.8534345267503, 2270.182734215681, 2288.5766133265233, 8416.326693864476, 8681.956590217009, 8734.563271836383, 8797.472151670856, 8824.779380515474, 5123.129068058439, 5298.523132918017, 5304.708241046741, 5305.549028332596, 5317.627766056377, 3184.9203769905707, 3198.9200269993435, 3240.578724765789, 3250.1874531367157, 3266.673332666738, 997.4065431068502, 1007.5365331947313, 1013.083159740436, 1031.0359813574332, 1036.5024788101678, 10424.478776061167, 11415.42922853854, 11511.539538418454, 11530.250533715365, 11532.308061516336, 4491.528389519119, 4493.213687604656, 4681.9297710534365, 4707.741074240881, 4711.764411779397, 9723.951380243054, 9836.458994755214, 9845.310828241954, 9873.506324683736, 10005.699829005142, 4510.548945105464, 5191.065608190562, 5201.45384734605, 5213.087709650796, 5236.214567814782, 4652.837150699709, 4727.267273572602, 4736.171170045297, 4773.212419950669, 4776.880577985578, 3871.9806400967814, 3892.1826416452864, 3905.1018265799025, 3948.9732669506134, 3956.149427873021, 1217.2088142707312, 1223.9143259971715, 1229.997551995121, 1242.453320538978, 1250.693580072888, 784.3803395317749, 786.7875673568219, 806.3589446390134, 815.4577206157957, 819.4591569564059, 5683.829485115453, 5685.857853553694, 5829.533637309005, 5851.882962340729, 5909.556783241274, 398.67507980995396, 398.7527732805621, 405.92896243157327, 840.6469282901196, 914.5427286356821, 3751.0, 3812.199438118026, 3909.7654140751647, 3987.521497420328, 3993.820278087435, 9982.0, 10277.640282590073, 10549.947250263853, 10556.0, 10708.250422470508, 10621.946890265499, 10623.52194151265, 10624.468776561142, 10630.936906309307, 10662.0, 7706.460547761603, 7871.567063811431, 7873.842523149505, 7917.841643167105, 7932.444728868923, 5504.80733174337, 5753.8561535961935, 5786.913196302143, 5924.911126333022, 6072.603301240651, 9700.708978730649, 9847.064528869745, 9992.950035249778, 10012.799744004933, 10041.799164016533, 8235.423520353517, 8900.243479304332, 10037.44794036335, 10074.395536267848, 10225.92627774073, 7116.395106416013, 7439.888401674088, 7447.776566703008, 7494.98817659609, 7573.545587264782, 8314.08545060055, 8419.789505262417, 8422.6209820557, 8426.03100643434, 8441.83116337682, 7323.414126869731, 7410.592417417094, 7464.477486575887, 7528.247175282428, 7578.772636820904, 7234.16807067194, 7250.238724933806, 7313.48805583604, 7425.405967522694, 7457.291557302047, 6820.965895170492, 6975.79072627822, 6983.615901125487, 6985.650717464208, 6998.895016574654, 4881.075901921756, 4931.235658472942, 4995.325631039763, 5011.599072074152, 5037.823676171316, 4181.372794080912, 4241.6606671466825, 4891.5353041461, 5008.9499105009945, 5070.112730272262], "value": 4405.578503537096, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [238.3124685282959, 270.1261419308535, 273.2839959306617, 279.1332911310381, 281.77598808946885, 3448.8275586220684, 3506.9123271918215, 3999.8800035998893, 4216.6898984297295, 4238.4066230727685, 3689.8708545200925, 3763.266163098197, 3883.398073298636, 3994.1412596291793, 4034.4150098235737, 3274.6234183068955, 3308.3217940322297, 3310.0, 3313.3207692423116, 3314.2542927841164, 2831.1223520708645, 3301.7688761786685, 3311.7019468247854, 3313.867445302185, 3321.618013928393, 2669.4927963686932, 3083.456148677339, 3146.9527957080663, 3278.606567211938, 3320.4189266878197, 3068.463018971693, 3273.558069660601, 3276.2300859298048, 3277.3281477297337, 3285.4743241081433, 2484.416162201881, 2597.4805038992276, 2710.566309390488, 2869.856507174633, 2895.102518219359, 3383.813890236036, 3703.981480092609, 3929.1945151243926, 3936.8031598419966, 3943.861964831217, 3610.526789149441, 3735.477033215352, 3736.8692095776787, 3743.1097295865416, 3788.522476234243, 3251.64231934487, 4371.16947779924, 4446.55534446556, 4456.665750068758, 4459.44256967879, 2636.5517861963513, 3062.493445005456, 3178.5855294393773, 3191.4255434021866, 3211.9561142628504, 4639.512851150648, 4665.127943806666, 4666.253399456071, 4681.46163191234, 4705.4588722296685, 3101.286704058079, 3230.3377807549396, 3232.563603913489, 3232.8383580820864, 3251.2847173621767, 3237.7409807215367, 3243.1243564237525, 3255.6581558936446, 3257.03917344384, 3275.6396796352383, 3187.7449804015623, 3575.0, 3718.0, 3733.6453036961443, 3736.8878933632036, 3674.375356189454, 3840.0591854995146, 4326.6754993375625, 4399.274119770266, 4467.776611169494, 927.6335847340263, 1016.8611155505881, 1022.2026819081128, 1111.6553868300853, 1135.3698697223122, 578.9739461724232, 685.6400389795398, 711.3668834737089, 713.4292565947221, 727.799131433129, 3402.1082080231604, 3421.775845700265, 3482.7710265430146, 3494.4408894576745, 3505.158761897126, 3322.8827605487277, 3567.840451853158, 3707.8516859325864, 3815.2911432882966, 3883.66988805949, 3094.5977022986867, 3490.2844916792506, 3507.31607336572, 3511.438169892805, 3514.701250393694, 1596.1460618569242, 1726.9740953885703, 1839.59528903641, 1855.639976621848, 2035.2266138867135, 3211.550382946389, 3755.849766009329, 3756.5116534850295, 3874.380099184117, 3989.202159568098, 3554.8717128926896, 3901.5903330150495, 3970.3448930926074, 3974.8274259093637, 3988.3818008208773, 3309.7848639838335, 3610.8555657773395, 3978.781167035841, 3983.900402489961, 3985.3623420253202, 2745.409736906575, 3775.565809931893, 3787.8484860605267, 3812.7331086823656, 3819.4097548304503, 2963.288810685463, 3549.4498352755363, 3569.303985722759, 3806.6003069677286, 3813.6949044075855, 3332.7167190789055, 3643.2713457309173, 3931.567527572022, 3955.4178328668763, 3992.54085780139, 2310.6880571122683, 2467.580511313117, 2689.3948861506788, 2765.14280573023, 2865.2550336912136, 3351.849166787452, 3361.9996102319083, 3799.297130030953, 4062.7562346258137, 4304.880731009897, 3698.593154753029, 4474.821007159677, 4483.506814250364, 4495.865124046284, 4497.920499080263, 3867.723651195155, 3891.8637847676328, 4196.475440569929, 4395.7142785718825, 4500.8649740507835, 3741.7278125437483, 4147.730397524151, 4342.109867477223, 4397.31841564558, 4411.426514553087, 4470.597646211857, 4487.753173575485, 4492.3935268738305, 4499.235130027969, 4541.159885421208, 4349.673774466864, 4420.823167073281, 4426.358178064227, 4432.512423633333, 4458.777061146994], "value": 3067.448415919801, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.6486108334999, 602.4216751918158, 621.3010363341241, 655.1515787055762, 696.7944456385366, 11195.664130076091, 11622.360770157638, 13928.164310141387, 14538.055026423275, 14549.0, 10524.315919465229, 12850.550230741926, 12942.0, 12946.223226606387, 12966.546170884021, 653.7646447278976, 678.220046946011, 804.8873157757934, 809.6518497046268, 829.742779738283, 835.1523203947967, 837.1753822484848, 839.6137776622761, 841.4446465332882, 843.6920524008723, 724.4168444402254, 883.9116088391173, 884.0364003236471, 888.5468411110348, 889.617464490269, 870.7823044238941, 873.681106396164, 873.8514452543083, 874.7419511244167, 882.7484167012403, 645.2192846655553, 652.6214795418646, 652.686710379016, 653.1998302079961, 653.4968074582545, 13746.0, 13916.02587818843, 13941.721165576631, 13943.233122178277, 13969.511067112704, 12224.938875305656, 12425.943794777455, 13352.799708004388, 13374.39815208318, 13518.391672374766, 8926.68756593516, 10910.727231819188, 10934.726631834188, 10971.396573188471, 11169.273997190157, 3400.1159698478327, 3443.6039855416698, 3445.1903802606366, 3468.289000754839, 3489.0928358626684, 113367.0, 117472.99999999914, 118657.62684746257, 120701.39649301698, 124389.0, 10120.089191972758, 10484.842727359095, 10532.736681583021, 10556.524956376981, 10919.235653504178, 20709.119949206663, 20865.165393384093, 20935.895320523603, 20949.0, 21165.788342116382, 7406.55560666351, 7493.437992150611, 7500.887486687704, 7560.659770310349, 7660.0, 4038.3134867072667, 4085.080856807195, 4111.835526578963, 4168.958310416918, 4194.916101677949, 3292.604887413526, 3304.3060957198777, 3403.2682973160395, 3412.488126781003, 3413.5562376890844, 585.487698264019, 620.5407998081387, 628.7767842415968, 638.664701031962, 643.3373625166087, 488.7067759344365, 544.5317027356471, 545.7516829842413, 552.8783667593123, 589.4311988930702, 8818.86771698425, 8987.955060224656, 9055.094490551024, 9085.409448385833, 9162.81674366509, 492.0675320268072, 503.77581976021054, 585.7217821534822, 593.9732712027969, 600.8793599936175, 3659.341318562684, 4156.314208155681, 4401.449818772653, 4532.456105267389, 4640.071985602893, 125296.0, 140336.8949465759, 141515.0, 145191.0, 154668.0, 79322.6033869827, 86390.70413943796, 107946.84106317986, 120787.39606301913, 123114.38442807729, 72533.91199132123, 80849.78725319124, 83985.32029359379, 100616.0, 107608.38587421195, 9457.38526995743, 9457.621695132393, 9545.474998875128, 9578.0, 9582.568784404579, 55358.44641553694, 59556.40443595508, 60000.39999599948, 61135.0, 61278.080828788494, 79839.60080199562, 80271.0, 92563.07436925815, 94267.52866235624, 97042.5147874256, 12154.635360939186, 12499.750004999667, 12554.372281386077, 12622.936885315514, 12832.871671283168, 13890.236037018061, 13892.652683682989, 14004.579862604138, 14516.20160891119, 14550.927245363706, 13263.66840828987, 13310.86689133135, 13482.258475783927, 13538.661533461742, 13912.373943172784, 12123.75752484963, 13039.478420863059, 13132.606021819362, 13193.340332983504, 13267.270300133585, 10811.513481893491, 12968.675783105498, 13023.674408139872, 13212.207267563977, 13631.931840340734, 9259.72220833376, 9490.240780737662, 10764.40795756241, 11021.889781102407, 11207.551697931991, 9849.65526206608, 10844.403557804397, 10908.400037997986, 11080.39057851826, 11103.5558577656], "value": 7303.351019447372, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1650.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 122.0, 123.0, 123.0, 122.0, 122.0, 121.0, 128.0, 114.0, 125.0], "value": 121.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 117.0, 167.0, 148.0, 150.0, 125.0, 114.0, 148.0, 118.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 229.0, 224.0, 226.0, 229.0, 230.0, 264.0, 286.0, 223.0, 227.0], "value": 236.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 61.0, 61.0, 83.0, 69.0, 63.0, 61.0, 54.0, 106.0, 88.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 74.0, 90.0, 75.0, 72.0, 76.0, 92.0, 72.0, 84.0, 90.0], "value": 81.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 91.0, 94.0, 92.0, 95.0, 93.0, 133.0, 92.0, 97.0, 120.0], "value": 100.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 99.0, 99.0, 101.0, 99.0, 123.0, 123.0, 122.0, 101.0, 100.0], "value": 110.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 123.0, 96.0, 169.0, 122.0, 162.0, 162.0, 106.0, 111.0, 106.0], "value": 127.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 58.0, 59.0, 66.0, 56.0, 61.0, 61.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 82.0, 82.0, 78.0, 77.0, 76.0, 86.0, 115.0, 114.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 97.0, 90.0, 88.0, 89.0, 90.0, 89.0, 93.0, 91.0, 91.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 159.0, 160.0, 172.0, 148.0, 148.0, 153.0, 177.0, 169.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [225.0, 241.0, 190.0, 173.0, 174.0, 176.0, 175.0, 170.0, 201.0, 245.0], "value": 197.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 73.0, 72.0, 71.0, 68.0, 69.0, 71.0, 77.0, 84.0], "value": 72.7, "unit": "score"}]}]} 19:10:40 INFO - Return code: 0 19:10:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:10:40 ERROR - # TBPL SUCCESS # 19:10:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:10:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:10:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:10:40 INFO - 2016-11-09 19:10:40.789 screenresolution[1680:11985] starting screenresolution argv=screenresolution get 19:10:40 INFO - 2016-11-09 19:10:40.791 screenresolution[1680:11985] Display 0: 1600x1200x32@60 19:10:40 INFO - 2016-11-09 19:10:40.798 screenresolution[1681:11988] starting screenresolution argv=screenresolution list 19:10:40 INFO - Available Modes on Display 0 19:10:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:10:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:10:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:10:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:10:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:10:41 INFO - Intel Iris: 19:10:41 INFO - Chipset Model: Intel Iris 19:10:41 INFO - Type: GPU 19:10:41 INFO - Bus: Built-In 19:10:41 INFO - VRAM (Dynamic, Max): 1536 MB 19:10:41 INFO - Vendor: Intel (0x8086) 19:10:41 INFO - Device ID: 0x0a2e 19:10:41 INFO - Revision ID: 0x0009 19:10:41 INFO - Displays: 19:10:41 INFO - Display: 19:10:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:10:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:10:41 INFO - Display Serial Number: 1600x1200 60 19:10:41 INFO - Main Display: Yes 19:10:41 INFO - Mirror: Off 19:10:41 INFO - Online: Yes 19:10:41 INFO - Rotation: Supported 19:10:41 INFO - Return code: 0 19:10:41 INFO - Running post-action listener: _resource_record_post_action 19:10:41 INFO - [mozharness: 2016-11-10 03:10:41.037895Z] Finished run-tests step (success) 19:10:41 INFO - Running post-run listener: _resource_record_post_run 19:10:41 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 32615424; Write bytes: 667337728; Read time: 322; Write time: 2013 19:10:41 INFO - TinderboxPrint: CPU usage
54.6% 19:10:41 INFO - TinderboxPrint: I/O read bytes / time
32,615,424 / 322 19:10:41 INFO - TinderboxPrint: I/O write bytes / time
667,337,728 / 2,013 19:10:41 INFO - TinderboxPrint: CPU idle
2,197.7 (45.4%) 19:10:41 INFO - TinderboxPrint: CPU system
985.9 (20.4%) 19:10:41 INFO - TinderboxPrint: CPU user
1,658.1 (34.2%) 19:10:41 INFO - TinderboxPrint: Swap in / out
392,863,744 / 0 19:10:41 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 360913408; Write bytes: 356697600; Read time: 29542; Write time: 662 19:10:41 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 30559232; Write bytes: 299363840; Read time: 298; Write time: 1313 19:10:41 INFO - Running post-run listener: _upload_blobber_files 19:10:41 INFO - Blob upload gear active. 19:10:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:10:41 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 19:10:41 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'] 19:10:41 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 19:10:41 INFO - (blobuploader) - INFO - Open directory for files ... 19:10:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:10:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:10:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:43 INFO - (blobuploader) - INFO - Done attempting. 19:10:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:10:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:10:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:44 INFO - (blobuploader) - INFO - Done attempting. 19:10:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:10:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:10:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:46 INFO - (blobuploader) - INFO - Done attempting. 19:10:46 INFO - (blobuploader) - INFO - Iteration through files over. 19:10:46 INFO - Return code: 0 19:10:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:10:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:10:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b072b7eed56edb77e7395cc14d5431a9421d649811d54f51537041c720dcb6ca0b3cd014cc077cd761f5b92fa93a0d5d5073abe41a499484c4e360501bba8eca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebc4bd2964dd62f41595abeffdfd82451209c74e3a5f50e294dff05b926cd374921ad1f59a4540384f4a1874588852719cceed3b4309a74da44aa9a000bbd34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27b46349b76af1e4f94fb49ee4f2f9a5981faaf49f76a34968965008d510c079f5af7ce38d1f183043ca89d128f3db3684954ece808fc4c803e1d54c0808cb1b"} 19:10:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:10:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:10:46 INFO - Contents: 19:10:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b072b7eed56edb77e7395cc14d5431a9421d649811d54f51537041c720dcb6ca0b3cd014cc077cd761f5b92fa93a0d5d5073abe41a499484c4e360501bba8eca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebc4bd2964dd62f41595abeffdfd82451209c74e3a5f50e294dff05b926cd374921ad1f59a4540384f4a1874588852719cceed3b4309a74da44aa9a000bbd34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27b46349b76af1e4f94fb49ee4f2f9a5981faaf49f76a34968965008d510c079f5af7ce38d1f183043ca89d128f3db3684954ece808fc4c803e1d54c0808cb1b"} 19:10:46 INFO - Running post-run listener: copy_logs_to_upload_dir 19:10:46 INFO - Copying logs to upload dir... 19:10:46 INFO - mkdir: /builds/slave/test/build/upload/logs 19:10:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.965413 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-09 19:10:46.467068) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 19:10:46.470313) ========= 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.H32j4zdBjG/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.Ql8ckatUZk/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b072b7eed56edb77e7395cc14d5431a9421d649811d54f51537041c720dcb6ca0b3cd014cc077cd761f5b92fa93a0d5d5073abe41a499484c4e360501bba8eca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebc4bd2964dd62f41595abeffdfd82451209c74e3a5f50e294dff05b926cd374921ad1f59a4540384f4a1874588852719cceed3b4309a74da44aa9a000bbd34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27b46349b76af1e4f94fb49ee4f2f9a5981faaf49f76a34968965008d510c079f5af7ce38d1f183043ca89d128f3db3684954ece808fc4c803e1d54c0808cb1b"} build_url:https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011959 build_url: 'https://queue.taskcluster.net/v1/task/U5ny2agdSay_c4hijJ76Zw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b072b7eed56edb77e7395cc14d5431a9421d649811d54f51537041c720dcb6ca0b3cd014cc077cd761f5b92fa93a0d5d5073abe41a499484c4e360501bba8eca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebc4bd2964dd62f41595abeffdfd82451209c74e3a5f50e294dff05b926cd374921ad1f59a4540384f4a1874588852719cceed3b4309a74da44aa9a000bbd34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27b46349b76af1e4f94fb49ee4f2f9a5981faaf49f76a34968965008d510c079f5af7ce38d1f183043ca89d128f3db3684954ece808fc4c803e1d54c0808cb1b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 19:10:46.505545) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 19:10:46.505921) ========= 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.H32j4zdBjG/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.Ql8ckatUZk/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.005412 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 19:10:46.554855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 19:10:46.555173) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 19:10:46.555519) ========= ========= Total master_lag: 0.17 =========