builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0111 starttime: 1477515891.1 results: success (0) buildid: 20161026004014 builduid: 0ff6334abedd49bb95ab30a9518c83be revision: a16ab27e533088e1711a82ff380d3ebd262ca837 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:51.098391) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:51.098847) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:51.099133) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:51.122257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:51.122660) ========= 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.msVL0oheYJ/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.i9lVXSo0kx/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-26 14:04:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.5M=0s 2016-10-26 14:04:51 (23.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085988 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:51.231062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:51.231424) ========= 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.msVL0oheYJ/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.i9lVXSo0kx/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.019630 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:51.280016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 14:04:51.280376) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a16ab27e533088e1711a82ff380d3ebd262ca837 --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 a16ab27e533088e1711a82ff380d3ebd262ca837 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.msVL0oheYJ/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.i9lVXSo0kx/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-26 14:04:51,355 truncating revision to first 12 chars 2016-10-26 14:04:51,355 Setting DEBUG logging. 2016-10-26 14:04:51,355 attempt 1/10 2016-10-26 14:04:51,355 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a16ab27e5330?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 14:04:52,403 unpacking tar archive at: mozilla-aurora-a16ab27e5330/testing/mozharness/ program finished with exit code 0 elapsedTime=1.334724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 14:04:52.637436) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:52.637763) ========= script_repo_revision: a16ab27e533088e1711a82ff380d3ebd262ca837 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:52.638177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:52.638447) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:52.656808) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-26 14:04:52.657233) ========= /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.msVL0oheYJ/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.i9lVXSo0kx/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:04:52 INFO - MultiFileLogger online at 20161026 14:04:52 in /builds/slave/test 14:04:52 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 14:04:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:04:52 INFO - {'append_to_log': False, 14:04:52 INFO - 'base_work_dir': '/builds/slave/test', 14:04:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:04:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:04:52 INFO - 'branch': 'Mozilla-Aurora', 14:04:52 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:52 INFO - 'config_files': ('talos/mac_config.py',), 14:04:52 INFO - 'default_actions': ('clobber', 14:04:52 INFO - 'read-buildbot-config', 14:04:52 INFO - 'download-and-extract', 14:04:52 INFO - 'populate-webroot', 14:04:52 INFO - 'create-virtualenv', 14:04:52 INFO - 'install', 14:04:52 INFO - 'run-tests'), 14:04:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:52 INFO - 'download_minidump_stackwalk': True, 14:04:52 INFO - 'download_symbols': 'ondemand', 14:04:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:52 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:52 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:52 INFO - 'installer_path': 'installer.exe', 14:04:52 INFO - 'log_level': 'info', 14:04:52 INFO - 'log_name': 'talos', 14:04:52 INFO - 'log_to_console': True, 14:04:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:04:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:04:52 INFO - 'opt_config_files': (), 14:04:52 INFO - 'pip_index': False, 14:04:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:04:52 INFO - 'cmd': ('bash', 14:04:52 INFO - '-c', 14:04:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:04:52 INFO - 'enabled': True, 14:04:52 INFO - 'halt_on_failure': False, 14:04:52 INFO - 'name': 'check_screen_resolution'},), 14:04:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:04:52 INFO - 'cmd': ('bash', 14:04:52 INFO - '-c', 14:04:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:04:52 INFO - 'enabled': True, 14:04:52 INFO - 'halt_on_failure': False, 14:04:52 INFO - 'name': 'check_screen_resolution'},), 14:04:52 INFO - 'run_cmd_checks_enabled': True, 14:04:52 INFO - 'sps_profile': False, 14:04:52 INFO - 'sps_profile_interval': 0, 14:04:52 INFO - 'suite': 'dromaeojs-e10s', 14:04:52 INFO - 'system_bits': '32', 14:04:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:52 INFO - 'title': 't-yosemite-r7-0111', 14:04:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:52 INFO - 'use_talos_json': True, 14:04:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:04:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:52 INFO - 'work_dir': 'build'} 14:04:52 INFO - [mozharness: 2016-10-26 21:04:52.848422Z] Running clobber step. 14:04:52 INFO - Running pre-action listener: _resource_record_pre_action 14:04:52 INFO - Running main action method: clobber 14:04:52 INFO - rmtree: /builds/slave/test/build 14:04:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:04:54 INFO - Running post-action listener: _resource_record_post_action 14:04:54 INFO - [mozharness: 2016-10-26 21:04:54.982083Z] Finished clobber step (success) 14:04:54 INFO - [mozharness: 2016-10-26 21:04:54.982205Z] Running read-buildbot-config step. 14:04:54 INFO - Running pre-action listener: _resource_record_pre_action 14:04:54 INFO - Running main action method: read_buildbot_config 14:04:54 INFO - Using buildbot properties: 14:04:54 INFO - { 14:04:54 INFO - "project": "", 14:04:54 INFO - "product": "firefox", 14:04:54 INFO - "script_repo_revision": "production", 14:04:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 14:04:54 INFO - "repository": "", 14:04:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 14:04:54 INFO - "buildid": "20161026004014", 14:04:54 INFO - "stage_platform": "macosx64", 14:04:54 INFO - "basedir": "/builds/slave/test", 14:04:54 INFO - "nightly_build": "True", 14:04:54 INFO - "buildnumber": 16, 14:04:54 INFO - "slavename": "t-yosemite-r7-0111", 14:04:54 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:04:54 INFO - "platform": "yosemite_r7", 14:04:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:04:54 INFO - "branch": "mozilla-aurora", 14:04:54 INFO - "repo_path": "releases/mozilla-aurora", 14:04:54 INFO - "revision": "a16ab27e533088e1711a82ff380d3ebd262ca837", 14:04:54 INFO - "pgo_build": "False", 14:04:54 INFO - "builduid": "0ff6334abedd49bb95ab30a9518c83be", 14:04:54 INFO - "slavebuilddir": "test" 14:04:54 INFO - } 14:04:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 14:04:54 INFO - Running post-action listener: _resource_record_post_action 14:04:54 INFO - [mozharness: 2016-10-26 21:04:54.985714Z] Finished read-buildbot-config step (success) 14:04:54 INFO - [mozharness: 2016-10-26 21:04:54.985812Z] Running download-and-extract step. 14:04:54 INFO - Running pre-action listener: _resource_record_pre_action 14:04:54 INFO - Running main action method: download_and_extract 14:04:54 INFO - mkdir: /builds/slave/test/build/tests 14:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:54 INFO - trying https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 14:04:54 INFO - Downloading https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/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 14:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/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 14:04:56 INFO - Downloaded 1199 bytes. 14:04:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:04:56 INFO - Using the following test package requirements: 14:04:56 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:04:56 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:56 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 14:04:56 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:56 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 14:04:56 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:56 INFO - u'jsshell-mac.zip'], 14:04:56 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:56 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 14:04:56 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:04:56 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:56 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 14:04:56 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:56 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 14:04:56 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:56 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 14:04:56 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:56 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 14:04:56 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:04:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:04:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:04:56 INFO - Fetch https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:04:57 INFO - Expected file size: 16420194 14:05:04 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 14:05:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 14:05:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:05:04 INFO - Fetch https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 14:05:04 INFO - Expected file size: 16420194 14:05:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 14:05:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:05:11 INFO - Fetch https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 14:05:11 INFO - Expected file size: 14414081 14:05:12 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')]} 14:05:12 INFO - trying https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:05:12 INFO - Downloading https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 14:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/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 14:05:15 INFO - Downloaded 115527563 bytes. 14:05:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:05:15 INFO - mkdir: /builds/slave/test/properties 14:05:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:05:15 INFO - Writing to file /builds/slave/test/properties/build_url 14:05:15 INFO - Contents: 14:05:15 INFO - build_url:https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:05:15 INFO - Running post-action listener: _resource_record_post_action 14:05:15 INFO - Running post-action listener: set_extra_try_arguments 14:05:15 INFO - [mozharness: 2016-10-26 21:05:15.972985Z] Finished download-and-extract step (success) 14:05:15 INFO - [mozharness: 2016-10-26 21:05:15.973147Z] Running populate-webroot step. 14:05:15 INFO - Running pre-action listener: _resource_record_pre_action 14:05:15 INFO - Running main action method: populate_webroot 14:05:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:05:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:05:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:05:15 INFO - '--tppagecycles', 14:05:15 INFO - '7'], 14:05:15 INFO - 'tests': ['tsvgm']}}, 14:05:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:05:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:05:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:05:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:05:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['damp', 'tps']}, 14:05:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'tests': ['damp', 'tps']}, 14:05:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['dromaeo_dom']}, 14:05:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:05:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['basic_compositor_video']}, 14:05:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:05:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'other-e10s': {'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['a11yr', 14:05:15 INFO - 'ts_paint', 14:05:15 INFO - 'tpaint', 14:05:15 INFO - 'sessionrestore', 14:05:15 INFO - 'sessionrestore_no_auto_restore', 14:05:15 INFO - 'tabpaint']}, 14:05:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['tsvgx', 14:05:15 INFO - 'tsvgr_opacity', 14:05:15 INFO - 'tart', 14:05:15 INFO - 'tscrollx', 14:05:15 INFO - 'cart']}, 14:05:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:05:15 INFO - 'tsvgr_opacity', 14:05:15 INFO - 'tart', 14:05:15 INFO - 'tscrollx', 14:05:15 INFO - 'cart']}, 14:05:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'talos_options': ['--disable-e10s'], 14:05:15 INFO - 'tests': ['tp5o']}, 14:05:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'tests': ['tp5o']}, 14:05:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'talos_options': ['--disable-e10s', 14:05:15 INFO - '--xperf_path', 14:05:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:15 INFO - 'tests': ['tp5n']}, 14:05:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:15 INFO - 'talos_options': ['--xperf_path', 14:05:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:15 INFO - 'tests': ['tp5n']}}, 14:05:15 INFO - 'talos.zip': {'path': '', 14:05:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:05:15 INFO - Running post-action listener: _resource_record_post_action 14:05:15 INFO - [mozharness: 2016-10-26 21:05:15.991585Z] Finished populate-webroot step (success) 14:05:15 INFO - [mozharness: 2016-10-26 21:05:15.991688Z] Running create-virtualenv step. 14:05:15 INFO - Running pre-action listener: _resource_record_pre_action 14:05:15 INFO - Running main action method: create_virtualenv 14:05:15 INFO - Creating virtualenv /builds/slave/test/build/venv 14:05:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:05:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:05:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:05:16 INFO - Using real prefix '/tools/python27' 14:05:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:05:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:19 INFO - Installing pip.................done. 14:05:19 INFO - Return code: 0 14:05:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10337b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96cb598130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, '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.msVL0oheYJ/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.i9lVXSo0kx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:19 INFO - 'HOME': '/Users/cltbld', 14:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:19 INFO - 'LOGNAME': 'cltbld', 14:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:19 INFO - 'MOZ_NO_REMOTE': '1', 14:05:19 INFO - 'NO_EM_RESTART': '1', 14:05:19 INFO - 'PAGER': '/bin/cat', 14:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:19 INFO - 'PWD': '/builds/slave/test', 14:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:19 INFO - 'SHELL': '/bin/bash', 14:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:05:19 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:19 INFO - 'USER': 'cltbld', 14:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:19 INFO - 'XPC_FLAGS': '0x0', 14:05:19 INFO - 'XPC_SERVICE_NAME': '0', 14:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:05:19 INFO - Cleaning up... 14:05:19 INFO - Return code: 0 14:05:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10337b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96cb598130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, '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.msVL0oheYJ/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.i9lVXSo0kx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:19 INFO - 'HOME': '/Users/cltbld', 14:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:19 INFO - 'LOGNAME': 'cltbld', 14:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:19 INFO - 'MOZ_NO_REMOTE': '1', 14:05:19 INFO - 'NO_EM_RESTART': '1', 14:05:19 INFO - 'PAGER': '/bin/cat', 14:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:19 INFO - 'PWD': '/builds/slave/test', 14:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:19 INFO - 'SHELL': '/bin/bash', 14:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:05:19 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:19 INFO - 'USER': 'cltbld', 14:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:19 INFO - 'XPC_FLAGS': '0x0', 14:05:19 INFO - 'XPC_SERVICE_NAME': '0', 14:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:20 INFO - Downloading/unpacking psutil>=3.1.1 14:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:23 INFO - Installing collected packages: psutil 14:05:23 INFO - Running setup.py install for psutil 14:05:23 INFO - building 'psutil._psutil_osx' extension 14:05:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:05:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:05:24 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 14:05:24 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 14:05:24 INFO - building 'psutil._psutil_posix' extension 14:05:24 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 14:05:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:05:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:05:24 INFO - ^ 14:05:24 INFO - 1 warning generated. 14:05:24 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 14:05:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:24 INFO - Successfully installed psutil 14:05:24 INFO - Cleaning up... 14:05:24 INFO - Return code: 0 14:05:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:05:24 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')]} 14:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:24 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')]} 14:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:24 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 0x10337b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96cb598130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, '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.msVL0oheYJ/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.i9lVXSo0kx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:05:24 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 14:05:24 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 14:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:24 INFO - 'HOME': '/Users/cltbld', 14:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:24 INFO - 'LOGNAME': 'cltbld', 14:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:24 INFO - 'MOZ_NO_REMOTE': '1', 14:05:24 INFO - 'NO_EM_RESTART': '1', 14:05:24 INFO - 'PAGER': '/bin/cat', 14:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:24 INFO - 'PWD': '/builds/slave/test', 14:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:24 INFO - 'SHELL': '/bin/bash', 14:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:05:24 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:24 INFO - 'USER': 'cltbld', 14:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:24 INFO - 'XPC_FLAGS': '0x0', 14:05:24 INFO - 'XPC_SERVICE_NAME': '0', 14:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:05:27 INFO - Installing collected packages: mozsystemmonitor 14:05:27 INFO - Running setup.py install for mozsystemmonitor 14:05:27 INFO - Successfully installed mozsystemmonitor 14:05:27 INFO - Cleaning up... 14:05:27 INFO - Return code: 0 14:05:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10337b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96cb598130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, '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.msVL0oheYJ/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.i9lVXSo0kx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:05:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:05:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:27 INFO - 'HOME': '/Users/cltbld', 14:05:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:27 INFO - 'LOGNAME': 'cltbld', 14:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:27 INFO - 'MOZ_NO_REMOTE': '1', 14:05:27 INFO - 'NO_EM_RESTART': '1', 14:05:27 INFO - 'PAGER': '/bin/cat', 14:05:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:27 INFO - 'PWD': '/builds/slave/test', 14:05:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:27 INFO - 'SHELL': '/bin/bash', 14:05:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:05:27 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:05:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:27 INFO - 'USER': 'cltbld', 14:05:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:27 INFO - 'XPC_FLAGS': '0x0', 14:05:27 INFO - 'XPC_SERVICE_NAME': '0', 14:05:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:27 INFO - Downloading/unpacking jsonschema==2.5.1 14:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:05:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:05:30 INFO - warning: no files found matching '*.txt' 14:05:30 INFO - no previously-included directories found matching 'build' 14:05:30 INFO - no previously-included directories found matching 'dist' 14:05:30 INFO - no previously-included directories found matching '.git*' 14:05:30 INFO - Installing collected packages: jsonschema, functools32 14:05:30 INFO - Running setup.py install for functools32 14:05:30 INFO - warning: no files found matching '*.txt' 14:05:30 INFO - no previously-included directories found matching 'build' 14:05:30 INFO - no previously-included directories found matching 'dist' 14:05:30 INFO - no previously-included directories found matching '.git*' 14:05:30 INFO - Successfully installed jsonschema functools32 14:05:30 INFO - Cleaning up... 14:05:31 INFO - Return code: 0 14:05:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:31 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 0x10337b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96cb598130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, '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.msVL0oheYJ/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.i9lVXSo0kx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:05:31 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 14:05:31 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 14:05:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:05:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:31 INFO - 'HOME': '/Users/cltbld', 14:05:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:31 INFO - 'LOGNAME': 'cltbld', 14:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:31 INFO - 'MOZ_NO_REMOTE': '1', 14:05:31 INFO - 'NO_EM_RESTART': '1', 14:05:31 INFO - 'PAGER': '/bin/cat', 14:05:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:31 INFO - 'PWD': '/builds/slave/test', 14:05:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:31 INFO - 'SHELL': '/bin/bash', 14:05:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:05:31 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:05:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:31 INFO - 'USER': 'cltbld', 14:05:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:31 INFO - 'XPC_FLAGS': '0x0', 14:05:31 INFO - 'XPC_SERVICE_NAME': '0', 14:05:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:05:31 INFO - Cleaning up... 14:05:31 INFO - Return code: 0 14:05:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:31 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 0x10337b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96cb598130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, '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.msVL0oheYJ/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.i9lVXSo0kx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:05:31 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 14:05:31 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 14:05:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:05:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:31 INFO - 'HOME': '/Users/cltbld', 14:05:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:31 INFO - 'LOGNAME': 'cltbld', 14:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:31 INFO - 'MOZ_NO_REMOTE': '1', 14:05:31 INFO - 'NO_EM_RESTART': '1', 14:05:31 INFO - 'PAGER': '/bin/cat', 14:05:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:31 INFO - 'PWD': '/builds/slave/test', 14:05:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:31 INFO - 'SHELL': '/bin/bash', 14:05:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:05:31 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:05:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:31 INFO - 'USER': 'cltbld', 14:05:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:31 INFO - 'XPC_FLAGS': '0x0', 14:05:31 INFO - 'XPC_SERVICE_NAME': '0', 14:05:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:31 INFO - Downloading/unpacking blobuploader==1.2.4 14:05:31 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 14:05:31 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 14:05:31 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 14:05:31 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 14:05:31 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 14:05:31 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 14:05:34 INFO - Downloading blobuploader-1.2.4.tar.gz 14:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:05:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:05:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:35 INFO - Downloading docopt-0.6.1.tar.gz 14:05:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:05:35 INFO - Installing collected packages: blobuploader, requests, docopt 14:05:35 INFO - Running setup.py install for blobuploader 14:05:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:05:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:05:35 INFO - Running setup.py install for requests 14:05:35 INFO - Running setup.py install for docopt 14:05:36 INFO - Successfully installed blobuploader requests docopt 14:05:36 INFO - Cleaning up... 14:05:36 INFO - Return code: 0 14:05:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:36 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 0x10337b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96cb598130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, '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.msVL0oheYJ/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.i9lVXSo0kx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:05:36 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 14:05:36 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 14:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:36 INFO - 'HOME': '/Users/cltbld', 14:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:36 INFO - 'LOGNAME': 'cltbld', 14:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:36 INFO - 'MOZ_NO_REMOTE': '1', 14:05:36 INFO - 'NO_EM_RESTART': '1', 14:05:36 INFO - 'PAGER': '/bin/cat', 14:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:36 INFO - 'PWD': '/builds/slave/test', 14:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:36 INFO - 'SHELL': '/bin/bash', 14:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:05:36 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:36 INFO - 'USER': 'cltbld', 14:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:36 INFO - 'XPC_FLAGS': '0x0', 14:05:36 INFO - 'XPC_SERVICE_NAME': '0', 14:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-UssQ7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-3Cog0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-OCCPed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-D6p5LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-TakaEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-D1fhxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-o6oawb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-jBmN34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-JMYs3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-h0lLWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-UOg499-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-0Zp7QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-hOv3KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-FSNXZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-8tmU6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ecZZVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-GbNAAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:05:38 INFO - Running setup.py install for manifestparser 14:05:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:05:38 INFO - Running setup.py install for mozcrash 14:05:38 INFO - Running setup.py install for mozdebug 14:05:38 INFO - Running setup.py install for mozdevice 14:05:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:05:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:05:38 INFO - Running setup.py install for mozfile 14:05:39 INFO - Running setup.py install for mozhttpd 14:05:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:05:39 INFO - Running setup.py install for mozinfo 14:05:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:05:39 INFO - Running setup.py install for mozInstall 14:05:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:05:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:05:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:05:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:05:39 INFO - Running setup.py install for mozleak 14:05:39 INFO - Running setup.py install for mozlog 14:05:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:05:39 INFO - Running setup.py install for moznetwork 14:05:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:05:39 INFO - Running setup.py install for mozprocess 14:05:40 INFO - Running setup.py install for mozprofile 14:05:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:05:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:05:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:05:40 INFO - Running setup.py install for mozrunner 14:05:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:05:40 INFO - Running setup.py install for mozscreenshot 14:05:40 INFO - Running setup.py install for moztest 14:05:40 INFO - Running setup.py install for mozversion 14:05:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:05:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:05:40 INFO - Cleaning up... 14:05:40 INFO - Return code: 0 14:05:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10337b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96cb598130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, '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.msVL0oheYJ/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.i9lVXSo0kx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:05:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:05:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:40 INFO - 'HOME': '/Users/cltbld', 14:05:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:40 INFO - 'LOGNAME': 'cltbld', 14:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:40 INFO - 'MOZ_NO_REMOTE': '1', 14:05:40 INFO - 'NO_EM_RESTART': '1', 14:05:40 INFO - 'PAGER': '/bin/cat', 14:05:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:40 INFO - 'PWD': '/builds/slave/test', 14:05:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:40 INFO - 'SHELL': '/bin/bash', 14:05:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:05:40 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:05:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:40 INFO - 'USER': 'cltbld', 14:05:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:40 INFO - 'XPC_FLAGS': '0x0', 14:05:40 INFO - 'XPC_SERVICE_NAME': '0', 14:05:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-RDEUGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:41 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)) 14:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-eE37X4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:41 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)) 14:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-kCXgS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-skgBpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-xOVe63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-68oz59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-aDCZvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-TZvKdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-w5bXXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:42 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)) 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-D4Dux9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:42 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)) 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-_bAW6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:42 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)) 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-CnxfzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:42 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)) 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-OV0vm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-TlkJ9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-jbaHoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-KHc39i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-nZL5a3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:45 INFO - Downloading blessings-1.6.tar.gz 14:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:05:45 INFO - Installing collected packages: blessings 14:05:45 INFO - Running setup.py install for blessings 14:05:45 INFO - Successfully installed blessings 14:05:45 INFO - Cleaning up... 14:05:45 INFO - Return code: 0 14:05:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:05:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:46 INFO - Reading from file tmpfile_stdout 14:05:46 INFO - Current package versions: 14:05:46 INFO - blessings == 1.6 14:05:46 INFO - blobuploader == 1.2.4 14:05:46 INFO - docopt == 0.6.1 14:05:46 INFO - functools32 == 3.2.3-2 14:05:46 INFO - jsonschema == 2.5.1 14:05:46 INFO - manifestparser == 1.1 14:05:46 INFO - mozInstall == 1.12 14:05:46 INFO - mozcrash == 0.17 14:05:46 INFO - mozdebug == 0.1 14:05:46 INFO - mozdevice == 0.48 14:05:46 INFO - mozfile == 1.2 14:05:46 INFO - mozhttpd == 0.7 14:05:46 INFO - mozinfo == 0.9 14:05:46 INFO - mozleak == 0.1 14:05:46 INFO - mozlog == 3.4 14:05:46 INFO - moznetwork == 0.27 14:05:46 INFO - mozprocess == 0.23 14:05:46 INFO - mozprofile == 0.28 14:05:46 INFO - mozrunner == 6.12 14:05:46 INFO - mozscreenshot == 0.1 14:05:46 INFO - mozsystemmonitor == 0.3 14:05:46 INFO - moztest == 0.7 14:05:46 INFO - mozversion == 1.4 14:05:46 INFO - psutil == 3.1.1 14:05:46 INFO - requests == 1.2.3 14:05:46 INFO - wsgiref == 0.1.2 14:05:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:46 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 0x10337b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96cb598130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, '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.msVL0oheYJ/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.i9lVXSo0kx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:05:46 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 14:05:46 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 14:05:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:05:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:46 INFO - 'HOME': '/Users/cltbld', 14:05:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:46 INFO - 'LOGNAME': 'cltbld', 14:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:46 INFO - 'MOZ_NO_REMOTE': '1', 14:05:46 INFO - 'NO_EM_RESTART': '1', 14:05:46 INFO - 'PAGER': '/bin/cat', 14:05:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:46 INFO - 'PWD': '/builds/slave/test', 14:05:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:46 INFO - 'SHELL': '/bin/bash', 14:05:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:05:46 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:05:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:46 INFO - 'USER': 'cltbld', 14:05:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:46 INFO - 'XPC_FLAGS': '0x0', 14:05:46 INFO - 'XPC_SERVICE_NAME': '0', 14:05:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:05:46 INFO - Cleaning up... 14:05:46 INFO - Return code: 0 14:05:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10337b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96cb598130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, '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.msVL0oheYJ/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.i9lVXSo0kx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 14:05:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:05:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:05:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:46 INFO - 'HOME': '/Users/cltbld', 14:05:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:46 INFO - 'LOGNAME': 'cltbld', 14:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:46 INFO - 'MOZ_NO_REMOTE': '1', 14:05:46 INFO - 'NO_EM_RESTART': '1', 14:05:46 INFO - 'PAGER': '/bin/cat', 14:05:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:46 INFO - 'PWD': '/builds/slave/test', 14:05:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:46 INFO - 'SHELL': '/bin/bash', 14:05:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:05:46 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:05:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:46 INFO - 'USER': 'cltbld', 14:05:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:46 INFO - 'XPC_FLAGS': '0x0', 14:05:46 INFO - 'XPC_SERVICE_NAME': '0', 14:05:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:05:46 INFO - Cleaning up... 14:05:46 INFO - Return code: 0 14:05:46 INFO - Running post-action listener: _resource_record_post_action 14:05:46 INFO - Running post-action listener: _start_resource_monitoring 14:05:46 INFO - Starting resource monitoring. 14:05:46 INFO - [mozharness: 2016-10-26 21:05:46.649143Z] Finished create-virtualenv step (success) 14:05:46 INFO - [mozharness: 2016-10-26 21:05:46.650133Z] Running install step. 14:05:46 INFO - Running pre-action listener: _resource_record_pre_action 14:05:46 INFO - Running main action method: install 14:05:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:46 INFO - Reading from file tmpfile_stdout 14:05:46 INFO - Detecting whether we're running mozinstall >=1.0... 14:05:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:05:47 INFO - Reading from file tmpfile_stdout 14:05:47 INFO - Output received: 14:05:47 INFO - Usage: mozinstall [options] installer 14:05:47 INFO - Options: 14:05:47 INFO - -h, --help show this help message and exit 14:05:47 INFO - -d DEST, --destination=DEST 14:05:47 INFO - Directory to install application into. [default: 14:05:47 INFO - "/builds/slave/test"] 14:05:47 INFO - --app=APP Application being installed. [default: firefox] 14:05:47 INFO - mkdir: /builds/slave/test/build/application 14:05:47 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'] 14:05:47 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 14:06:18 INFO - Reading from file tmpfile_stdout 14:06:18 INFO - Output received: 14:06:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:06:18 INFO - Running post-action listener: _resource_record_post_action 14:06:18 INFO - [mozharness: 2016-10-26 21:06:18.986455Z] Finished install step (success) 14:06:18 INFO - [mozharness: 2016-10-26 21:06:18.986600Z] Running run-tests step. 14:06:18 INFO - Running pre-action listener: _resource_record_pre_action 14:06:18 INFO - Running main action method: run_tests 14:06:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:06:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:06:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:06:19 INFO - 2016-10-26 14:06:19.001 screenresolution[1925:18686] starting screenresolution argv=screenresolution get 14:06:19 INFO - 2016-10-26 14:06:19.003 screenresolution[1925:18686] Display 0: 1600x1200x32@60 14:06:19 INFO - 2016-10-26 14:06:19.009 screenresolution[1926:18688] starting screenresolution argv=screenresolution list 14:06:19 INFO - Available Modes on Display 0 14:06:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:06:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:06:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:06:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:06:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:06:19 INFO - Intel Iris: 14:06:19 INFO - Chipset Model: Intel Iris 14:06:19 INFO - Type: GPU 14:06:19 INFO - Bus: Built-In 14:06:19 INFO - VRAM (Dynamic, Max): 1536 MB 14:06:19 INFO - Vendor: Intel (0x8086) 14:06:19 INFO - Device ID: 0x0a2e 14:06:19 INFO - Revision ID: 0x0009 14:06:19 INFO - Displays: 14:06:19 INFO - Display: 14:06:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:06:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:06:19 INFO - Display Serial Number: 1600x1200 60 14:06:19 INFO - Main Display: Yes 14:06:19 INFO - Mirror: Off 14:06:19 INFO - Online: Yes 14:06:19 INFO - Rotation: Supported 14:06:19 INFO - Return code: 0 14:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:06:19 INFO - Python 2.7.3 14:06:19 INFO - Return code: 0 14:06:19 INFO - grabbing minidump binary from tooltool 14:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:19 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 0x10318fd30>, '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 0x102ff5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103187b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:06:19 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 14:06:19 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 14:06:19 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 14:06:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:06:19 INFO - Return code: 0 14:06:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:06:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:06:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:06:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:06:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:06:19 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/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 14:06:19 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/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --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 14:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msVL0oheYJ/Render', 14:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:19 INFO - 'HOME': '/Users/cltbld', 14:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:19 INFO - 'LOGNAME': 'cltbld', 14:06:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:06:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:19 INFO - 'MOZ_NO_REMOTE': '1', 14:06:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:06:19 INFO - 'NO_EM_RESTART': '1', 14:06:19 INFO - 'PAGER': '/bin/cat', 14:06:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:19 INFO - 'PWD': '/builds/slave/test', 14:06:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:19 INFO - 'SHELL': '/bin/bash', 14:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9lVXSo0kx/Listeners', 14:06:19 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 14:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:19 INFO - 'USER': 'cltbld', 14:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:19 INFO - 'XPC_FLAGS': '0x0', 14:06:19 INFO - 'XPC_SERVICE_NAME': '0', 14:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:19 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/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 14:06:19 INFO - mozversion application_buildid: 20161026004014 14:06:19 INFO - mozversion application_changeset: a16ab27e533088e1711a82ff380d3ebd262ca837 14:06:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:06:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:06:19 INFO - mozversion application_name: Firefox 14:06:19 INFO - mozversion application_remotingname: firefox-dev 14:06:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:06:19 INFO - mozversion application_vendor: Mozilla 14:06:19 INFO - mozversion application_version: 51.0a2 14:06:19 INFO - mozversion platform_buildid: 20161026004014 14:06:19 INFO - mozversion platform_changeset: a16ab27e533088e1711a82ff380d3ebd262ca837 14:06:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:06:19 INFO - mozversion platform_version: 51.0a2 14:06:19 INFO - using testdate: 1477515979 14:06:19 INFO - actual date: 1477515979 14:06:19 INFO - starting webserver on 'localhost:57281' 14:06:19 INFO - SUITE-START | Running 2 tests 14:06:19 INFO - TEST-START | dromaeo_css 14:06:19 INFO - operating with platform_type : mac_ 14:06:19 INFO - Initialising browser for dromaeo_css test... 14:06:19 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpvI8wuf/profile http://localhost:57281/getInfo.html) 14:06:22 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 14:06:22 INFO - PROCESS | 1936 | colorDepth:24 14:06:22 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 14:06:22 INFO - PROCESS | 1936 | __metrics 14:06:22 ERROR - PROCESS | 1936 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 14:06:23 INFO - TEST-INFO | 1936: exit 0 14:06:23 INFO - Browser initialized. 14:06:23 INFO - Running cycle 1/1 for dromaeo_css test... 14:06:23 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpvI8wuf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:35 INFO - PROCESS | 1940 | RSS: Main: 224923648 14:06:35 INFO - PROCESS | 1940 | 14:07:24 INFO - PROCESS | 1940 | 1477516044808 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] 14:09:36 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:57281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57281/tests/dromaeo/cssquery-ext.html) 14:09:38 INFO - PROCESS | 1940 | RSS: Main: 236613632 14:09:38 INFO - PROCESS | 1940 | 14:12:40 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:57281/tests/dromaeo/cssquery-ext.html (next: http://localhost:57281/tests/dromaeo/cssquery-jquery.html) 14:12:41 INFO - PROCESS | 1940 | RSS: Main: 248905728 14:12:41 INFO - PROCESS | 1940 | 14:15:43 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:57281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57281/tests/dromaeo/cssquery-mootools.html) 14:15:43 INFO - PROCESS | 1940 | RSS: Main: 251351040 14:15:43 INFO - PROCESS | 1940 | 14:18:45 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:57281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57281/tests/dromaeo/cssquery-prototype.html) 14:18:46 INFO - PROCESS | 1940 | RSS: Main: 251551744 14:18:46 INFO - PROCESS | 1940 | 14:21:49 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:57281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57281/tests/dromaeo/cssquery-yui.html) 14:21:49 INFO - PROCESS | 1940 | RSS: Main: 256106496 14:21:49 INFO - PROCESS | 1940 | 14:24:52 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:57281/tests/dromaeo/cssquery-yui.html (next: http://localhost:57281/tests/dromaeo/cssquery-dojo.html) 14:24:52 INFO - PROCESS | 1940 | RSS: Main: 257765376 14:24:52 INFO - PROCESS | 1940 | 14:24:52 INFO - PROCESS | 1940 | __start_tp_report 14:24:52 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 14:24:52 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 14:24:52 INFO - PROCESS | 1940 | |i|pagename|runs| 14:24:52 INFO - PROCESS | 1940 | |0;dojo.html;3449.1032331593788;3453.879114231001;3464.0820182651587;3478.843452044657;3482.2687235680505;5799.594028418007;5819.098039803832;5830.737616807243;5839.065749480084;5844.925051606682;5804.970975145129;5849.151872978427;5874.471297583216;5883.411658834115;5903.616264942786;4758.405199350082;4974.726390048546;5345.465453454643;5364.892702145955;5385.78456861725;5052.418971818232;5174.922376164342;5396.703181325026;5401.594880383967;5407.972960135214;5269.473052694719;5275.050490911634;5363.54409875161;5370.892582148354;5393.1101368274185;4657.976710116462;5220.008198442284;5226.947730522684;5311.336082989626;5350.5452036576935;4228.978855105735;5154.355705536808;5164.225366195101;5179.559737422323;5257.921131183035;5651.434856514356;5711.914321285184;5749.195112684228;5770.076787713946;5791.942080579224;6105.763021687103;6173.9073913891325;6211.596246243979;6211.751529938797;6244.6253224806205;6263.561550691454;6283.340249273851;6301.08634248036;6307.96846015767;6318.4629306509005;5853;5939.554533410012;5946.07835785454;5955.940440595626;5965.970170149165;6295.24457065146;6359.395857393541;6384.32964538726;6387.201599800025;6397.552171348054;6190.133381326528;6259.280182779039;6259.3427690091885;6263.029230469285;6294.748210071637;6149.200603921461;6199.504039676815;6213.937860621426;6280.995040793451;6308.337624549448;6240.157578726814;6280.685965701697;6307.117003619497;6308.243010838729;6314.021326694278;6266.811995640138;6268.686565671698;6271.717772700239;6285.779997700059;6340.4293613575;4922.163232250526;4940.182548083621;4948.752562371867;4997.250412438163;5036.992601479718;4440.33394990754;4445.222086134913;4466.910661786811;4500.099980004013;4537.636989040869;5056.292119103328;5290.809567847204;5516.7517461714315;5914.99445094335;6017.247844019497;6188.907166392508;6261.217347831521;6284;6292.465140463112;6302.873942521124;5877.206577112121;5947.672877991666;5959.76160953557;6011.879762404727;6069.453749162508;5478.780848766084;5482.643628164156;5495;5498.367687715884;5515.586331025189;5476.479734425223;6448.258450278278;6512.088307637029;6534;6552.312007239362;6126.120738204555;6183.907241391293;6223.19098517208;6231.813045608639;6255.96872015637;5394.595405344537;6480.625701877237;6494.935050649433;6507.902381464377;6521.445677117308;6215.81352559424;6246.187995560548;6278.843028924313;6279.591826531261;6289.937100628935;6123.679189354688;6132.264128304632;6194.256689197326;6229.875402492015;6298.401651843067;5147.9227811583605;6187.16473276102;6219.844503887439;6220.440160385587;6229.906551401823;6199.473044791062;6204.5036397089025;6212.565120441706;6213.689315534115;6226.688665566794;5248.396434410091;5995.91006134917;6039.214902062704;6055.5458340623745;6106.114613380946;6138.51101655979;6183.319834818257;6207.224096987877;6218.409251121137;6219.720112595034;6050.1227322037175;6091.664958427329;6100.2829925465485;6112.297085835008;6139.140520327247 14:24:52 INFO - PROCESS | 1940 | |1;ext.html;473.1058299813352;493.1271649180952;508.95164959328866;523.6099106165907;548.2078396716746;32785.67214327856;40028.59971400285;40151.79544613659;40300.798496007475;40391.59608403915;41080.58919410805;41556.37665435013;41569.96075098124;41580.79209603948;41587.58412415875;9653.806923861519;9823.95088024559;9886.851697224547;9889;9889.554970026365;9765.462899540522;9782.706518804413;9845;9860.063293987096;9869;9836.458994755285;9841.21270298378;9848.950755246215;9851.95074024629;9852.113309802116;9790.069943355405;9812.165965892944;9822.901770982271;9841.409515429097;9870.161036311922;9737.172340351079;9781.608735650565;9807.362521436084;9811.803763924752;9830.361026533252;38956.415653765216;39409.40885886714;39679.8016009921;39696.60303396987;39775.60224397748;3168.9683103168904;3343.5987681478136;3431.7083047940955;3716.758410703296;3767.472553842464;30015.949441769433;30061.849690751624;31125.37749245025;31992.840035799672;32195.83902080498;3232.7090561849545;3309.9007029789145;3348.196432856097;3439.329330780499;3466.254755227613;491255;502974;504447.99999999633;505676.47161764326;506077;28247.29381765472;32809;46446;53253.46746532485;56904.43095568991;34731.13172170665;34976.65023349734;35091.82454087764;35103.82448087743;35293.82353088218;14765.704685906221;14850.257487125817;14869.553913382615;14873.851261487247;15102.320395582225;12521.311327877054;12555.309457979716;12653.493860245671;12667.683307917376;12712.300823454614;7555;7672.884906726404;7679.6160191990175;7741.07107147146;7748.302652761278;3094.845257737104;3269.9509507357407;3269.967300327014;3276.950845737316;3308.2556424804225;927.6521304510809;973.9464329461948;1039.0129377091794;1040.5889673579045;1082.6156714366286;29221.41557168845;29436;30170.396592068035;30464.84767576148;30548.38903221923;1056.6738742877792;1127.8383265236819;1155.751513424601;1168.339887963298;1185.1763024697752;14929.850701493064;15517.922410387875;15531.45639902598;15550.222488875512;15879.920600396925;518600;579863;677131.6143419251;687435;690887.5455622791;54993.90012199814;55181;55320;55928.72035639796;55942.72028639912;1356.4980957045957;1359.64649191211;1379.4620098161724;1379.7447472217673;1381.5233744358181;29119;29727.70272297249;29883.55174672338;30083.94706185273;30517;44105;44199.55800442083;44326;45769.54230457653;48681.513184869116;575232;580497;584419;584497;586587;25642.358941025876;26030.088946886768;26272.34319142037;26289;26352;44652.55347446614;46358.53641463542;46445.838854028916;46663.30005049995;47094.52905470901;37634.05914852041;38340.61659383482;38929.1200351105;39519.604803951595;39650.40524392194;38161.427578586896;38205.4269185968;38546.229075418894;38618.22763544657;39569.80215098906;37599.81200093982;37849.432258516696;38272.808635956644;38886.8333949982;38971.415428769156;32735;34022.14944626404;34184;34909.301813964084;35072.9478115657;25471.773230352705;25493;25505;25650;25846.483070338112 14:24:52 INFO - PROCESS | 1940 | |2;jquery.html;380.1124374585343;383.1035377217311;386.5554612195974;392.2273121949758;412.97522148671084;19128.42614721557;20581.176752929903;20900.268490602833;21497.892510537466;21738.782612173894;20079.397618071445;20435.284765033226;20489.692654610193;20540.383788486368;20865.478363040933;4981;5918.260217472816;6046.33490316067;6120.938790612104;6145.938540614604;5873.7356818943035;6035.124906888521;6142.692865356737;6159.9384006160035;6175.66033868137;5990.520758339322;6025.638461692291;6064.72708728106;6068.969655151718;6069.0592958091565;4790.856274311776;5006.973570418056;6015.54883383748;6042.879142417149;6044.5164386849165;4385.3641222022625;5227.189785583203;5232.372115346183;5244.737763111829;5246.23929530216;22522.54954900909;25130.49739005228;25616.359591010187;25622.975080996737;25839.708014599382;2343.7304709958403;2388.605880029793;2464.445499762539;2508.1723031399592;2991.2521869532616;15015.699686006219;15109.471168509159;15426.614334641612;16232;16288.429904953387;1517.5674932644254;1844.3729132095152;1873.878197917131;1880.3042874136656;1904.4953087431702;81397.59301203515;108536.4573177129;110777.44611276891;116022.41988790002;122649.38675306566;10359.585616575403;10663.73340666474;10909.39998300101;11023.228374013903;11162.330260184415;11789.528418863321;13164.946804255636;13727.725445491034;13734.793978090336;13755.518556850462;6923.861522769516;7339.339459448675;8745.212930836255;8749.737507874774;8776.648934042694;8766.693165739169;8788.209061184523;8819.559022048872;8893.688720894737;8943.284537237136;6497.480201583862;6560.737570497222;6606.6036037837885;6654.26803051664;6748.089007983957;1816.1464111867401;1838.8069252728271;1852.7961924188328;1855.5082903030707;1856.2574970011833;893.5487578772678;904.5703290936752;920.5213289089636;944.5466176235308;947.7014740356766;18067.00631465282;20155;20744.48138796512;22126.446838829157;22338.553228935656;932.7947851472666;943.2501161576563;968.8692026576463;980.6665733650593;997.5411310797115;10862.565497380174;11660.825087623693;11685.357305348118;11719.941400293115;11780.939715425482;578046;589114;590729;591211;596874.0312596818;101282;101721.98278017274;109431.45284273528;112822.70959000917;113996;932.1191474056951;938.2494004796272;945.9101385368378;950.0689324462066;979.8481235408523;18291.359802406852;19237.903810480857;19656.0171991397;19766.40700778979;19794.90102549478;50334.74832625814;50394;52307;52682;53622.46377536331;71358;71445.57108857897;74634.62682686551;75662.24337756552;76954.61522692574;7708.49894756839;7824.92175078242;7908.209179082046;7985.5208687478935;8114.837703245784;11234.101271898391;11615.6515304541;12163.148579599698;12403.317817520123;13032.869671303166;9725.756856078371;10471.528781204712;10770.73073173177;10874.34753914736;10980.835287470534;10902.727431813952;10961.45192740344;11137.721556961142;11233.045191158517;11283.097352211638;10828.187885908746;10869.728256793644;11027.739313440887;11309.491072901903;11451.25566838153;7725.188855170126;7735.535867847947;7884.763457096296;7957.681692732457;7969.402294827795;8174.67301307941;10279.486025698536;10829.133669306595;11003.724906877393;11168.329900206014 14:24:52 INFO - PROCESS | 1940 | |3;mootools.html;1493.3727834309589;1498.1235976953478;1723.0351003438075;1815.1559524820955;1866.1882081294639;8007.799805004864;8330.708425205119;8554.358423118269;9163.404378715379;9185.816283674323;8621.741347759562;8929.062448442917;8957.10428957104;9025.864612030808;9028.32287578431;1979.2874565156533;2373.264288070695;2390.2231774673214;2391.7129944406697;2396.9760302397012;2349.3304408243653;2370.9407264818346;2396.18529699902;2397.2688330059327;2408.5664580375524;2357.7642235776457;2369.680093187415;2374.1097088591778;2398.8560686358787;2401.5076909233567;2355.5171189906027;2370.4429459077105;2371.2412028150998;2378.9048438062455;2382.725986511556;2367.8342516023886;2382.487765130505;2382.559226543078;2384.5588566115325;2385.2009576791797;8357.791055223608;8376.120507346763;8423.83152336956;8449.281811046068;8960.955195223982;5268.341457317835;5396.5952553558245;5411.458854114597;5415.620906536544;5418.106012507971;3573.6426357364317;3595.3708101082207;3611.1513794258326;3618.8552457901915;3732.9066773330615;1086.6794295682791;1090.3076546393097;1091.9344839309667;1110.1673744691482;1124.280460505269;11469.197156199069;11671.007964323042;11674.766504669944;11683.299002059903;11689.941550292278;4562.061124022343;4646.070785842845;4789.994101238709;4801.039792041605;4808.35087263215;9914.206863450907;10067.798644027225;10069.69790906274;10072.043155900177;10115.848262276071;5359.249705041298;5370.4361042090795;5386.649867758583;5388.91916621251;5400.21696853954;4351.216780979391;4514.88712782183;4754.405699287589;4892.412910450697;4940.629452791055;3257.951130733041;3939.4484772131923;4003.9990002499376;4038.293298672779;4051.230266249403;1286.003347405768;1291.838520184977;1296.6887946892866;1300.440810451496;1311.1608570514877;888.1695614600369;888.3870129610548;901.6573701993201;906.410832958569;914.9679761208325;5792.304923409133;5857;5948.226730525004;6147.508199344042;6210.441060304594;451.62289488276997;451.988700282489;452.8279253883569;459.79998700565363;467.5161208149549;3885.756557901501;3975.3043217436834;4077.673786097105;4100.5899410058755;4138.710290279651;9452.52737363129;10949;10972.122230221563;10976.506057227443;10977.670669879917;10091.091801737879;10695.465226738632;10742.677719668422;10820.945895270474;10913.345199288067;7323.157836848724;8088.797780055545;8198.549079800548;8285.917140828515;8338.708145214767;4818.903621927612;5833.912491312549;5867.9413205869105;5920.615160014585;6109.144719739329;9880.40717556949;9954.651587194414;9991.300608957594;10043.096121349114;10084.445355505517;10003.499825008867;10008.749781255527;10225.897741022494;10261.692149235534;10426.270161088954;7015.614141222078;7155.499115061895;7536.849263014599;7551.169371369255;7630;7047.330503602149;7102.5028248022145;8451.197136272045;8496.787580310542;8512.914870851213;7422.220666829905;7529.811754705957;7575.318221360104;7595.126560445619;7668;7349.963250183715;7404.148522919718;7436.888446673413;7492.475526713078;7529.209433009674;7043.2604576518725;7056.894146587908;7101.360877521048;7120.252373500708;7124.323189297009;5035.866929940734;5072.5688316493515;5078.720670363018;5197.558207552401;5212.817551385683;5035.244713293036;5038.521340472649;5098.643094983464;5136.9743151284;5155.072087024371 14:24:52 INFO - PROCESS | 1940 | |4;prototype.html;262.68215459294254;268.9193242027392;304.54622612307656;316.4035792531078;318.20766291933063;3901.414787781834;4557.544245575441;5429.755660995254;5492.747973330936;5616.269884914966;3801.2777572261252;5397.055515284829;5482.616216864821;5501.174823776426;5564.221009058725;3707.3141468828217;4128.58714128587;4229.386738922854;4240.915181696364;4261;4048.817803198848;4205.642520385755;4239.576042395766;4242.321228603424;4258.765767882765;3406.5571475708125;4128.669706423494;4130.339145736668;4148.917021659565;4179.832806687728;3419.384510788057;4160.708750387459;4163.458750362433;4194.8112334945;4221.957780422218;3643.927121457556;3656.3235801376563;3665.4685070664605;3669.7798132111893;3689.594144644087;4567.995041090955;4722.976385118052;4795.064962332347;4947.109520286347;5274.180407759355;3635.291118231946;4768.47546769855;4779.235322348442;4805.519448055202;4828.589569886564;4809.927851082237;5228.660137091077;5311.804843910128;5748.798792042258;5774.7478483391515;3837.194189220267;3983.820728067244;3991.9201615967518;3993.3211354069585;4010.453362115078;5606.505105228175;5852.707364631751;6087.178230938855;6169.722362493699;6188.84527886802;3373.983130084334;4051.6150965658217;4075.918481630351;4076.144009757984;4087.734297270668;3363.5963684358035;4054.2499637567144;4093.488313960755;4093.5087789465456;4111.546301107024;3980.900477488028;4591.563801438858;4677;4727.125481785881;4803.807847686124;4644.790984405709;5139.486051394905;5919.881602367928;5921.496672782776;5994.250718660168;1152.8731839497648;1299.740051989606;1383.273781264844;1393.303348325837;1395.5813256023152;920.4661296448044;939.9389039712534;944.4758159221698;952;957.3298690916387;4629.560191781776;5051.236828562744;5504.449555044544;5558.110702287696;5583.944160558423;5776.740046697909;6053.606515576562;6065.848353791102;6070.423309785563;6104.511639068953;5408.810691625774;5457.836264912059;5558.0269004503625;5564.387917329091;5577.908284393353;2312.583734927729;2642.973570264273;2654.376221587925;2666.4800363929235;2684.1813246959864;4255.404243405926;4390.034192477649;4773.952260477351;5335.33308336458;5388.8952764683145;4217.957820421818;4289.485261768607;4318.546552611993;4443.911121777546;4464.718431952512;4240.787960601958;4584.335271385564;4762.903902643724;5019.970905964342;5358.8660283492445;4401.371492547778;5039.722815245197;5153.613478989016;5185.688858668492;5217.6086793491395;4848.3454733610515;5037.244413338029;5447.836564903059;6031.909521357095;6054.576179667381;5196.68819870809;6426.3573642635365;6444.581102228341;6447.710457908343;6474.676266186578;3364.8317584121187;3994.920101597894;4027.7381970171846;4060.837566497307;4069.89825254371;5085;5504.9449505504435;5737.770489180386;6012.969935150296;6068.7269072892705;4406.493253275914;5652.604317697722;5812.82561523155;5830.2129212555765;5944.603018290784;5114.820981265638;5804.1293805929445;5885.528617845539;5946.791862284799;5999.670018149044;5600.915986260291;5752.338481074563;5802.274715660543;5806.564507662027;5824.94175058244;5812.389699081536;5899.557533185114;5931.6441013539325;5992.340842507234;6004.979153543995;4441.977790111029;4695.788689509049;4957.206846904478;5314.335708036496;5844.678542680023 14:24:52 INFO - PROCESS | 1940 | |5;yui.html;744.4677055905029;762.4929421934414;770.5376773935636;804.8631732605456;832.0306842528456;13019.218846869182;13864.792028119573;14548.781768273471;15066.924665376686;15088.245587720598;11102.333859968387;11742.001929835953;13432;13517;13813.861861381383;806.8749343851698;812.4475356757403;837.3175861672747;837.9497230166179;845.0873057098319;830.2320353672859;831.0110967948152;832.5337810825927;833.2417500074934;834.2366734437982;845.1970627903486;864.0624921959682;877.3419935048713;879.3536750488386;881.8060026794095;819.5328662662284;875.5753459572103;876.2201640539924;876.9561521923911;878.6573236437795;543.3941155611504;638.2277444292412;640.6412409050946;648.3354561574424;650.9479241660656;14718.116912985255;14741.410343586243;14826.406943722239;14843;14868.256587170597;14022.789658155136;14175.432982680784;14199.361028753627;14353.64115897111;14441.638959026004;11861.975196324967;11978.64064078079;12030;12033.217840840405;12230.960368368611;3669.321175582499;3697.9445308320396;3750.8687195948282;3829.3872980323013;3861.6331448512346;92008;131535;131820;133897.6356300403;135051;10686.0916822071;10973.615923442801;11015.266720930713;11139.498722557504;11170.329780213213;22188.55622887533;22429.775702243096;22528.662070068964;22640.773592264195;22696.65955010676;7966.322862556632;7992.600369981594;8042.517448953082;8157;8236.917630823735;3861.2277544490653;4458.308962110878;4535.841245556389;4546.772661366985;4563.110193512233;3590.030691713223;3683.355412802749;3692.5568931727826;3717.107894105395;3723.8138093095235;673.7170388436869;679.1137565477001;680.618853442074;681.2914568848342;692.2731132311154;598.5032423088912;663.5288944849115;675.2786271326562;677.6814896998403;698.1726653915127;8982.955085224663;9398.107179817905;9500;9750;9801.11789938909;564.5314389057073;626.9843253918598;640.5260107520402;650.2392201124695;685.7702669605738;4421.955780442155;4565.726056436624;4613.907721845611;4629.259318509023;4772.976135119302;151428.242858785;154500.2274988618;159859;163143.36856631518;163917;113097.4345128269;115837.26244106345;117655;125054.37472812578;131907.34046329898;87972.5601371989;102384;112740;115394.423027886;115580.84419155869;7896.447248692766;9757.21942244633;9821.36161149523;10029.398236105857;10145.391276523433;59673;62469;62487.062694060536;64156;64726.02910956245;69603.30396695968;82680.58659706663;86011.27977440291;87485.25029499501;87885;10764.03123718869;12995.870041299466;13223.603291901258;13251.337433128498;13401.53094641683;11783.88216117862;12230.327331996825;14044.78932815988;14907.627309317353;14991.77512337294;11087.944560277147;12596.370181490705;12770.87229127734;13214.405351759386;13590.796138058135;13364.933175334061;13773.793393099311;14120.717585648435;14283.785743213652;14285.428582856985;13055.151415157985;13639.931800340935;13641.79537306961;13675.589732308046;13908.235047072509;8817.814975339805;10751.13990880712;11069.225154239448;11215.102791776475;11582.826257605973;9616.711498655051;10703.785924281627;11498.425078745862;11656.941715291368;11736.530538778354 14:24:52 INFO - PROCESS | 1940 | __end_tp_report 14:24:52 INFO - PROCESS | 1940 | __start_cc_report 14:24:52 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,368 14:24:52 INFO - PROCESS | 1940 | __end_cc_report 14:24:52 INFO - PROCESS | 1940 | __startTimestamp1477517092289__endTimestamp 14:24:52 INFO - PROCESS | 1940 | 14:24:52 INFO - PROCESS | 1940 | ------- Summary: start ------- 14:24:52 INFO - PROCESS | 1940 | Number of tests: 6 14:24:52 INFO - PROCESS | 1940 | 14:24:52 INFO - PROCESS | 1940 | [#0] dojo.html Cycles:165 Average:5789.36 Median:6069.45 stddev:663.50 (10.9%) stddev-sans-first:639.63 14:24:52 INFO - PROCESS | 1940 | Values: 3449.1 3453.9 3464.1 3478.8 3482.3 5799.6 5819.1 5830.7 5839.1 5844.9 5805.0 5849.2 5874.5 5883.4 5903.6 4758.4 4974.7 5345.5 5364.9 5385.8 5052.4 5174.9 5396.7 5401.6 5408.0 5269.5 5275.1 5363.5 5370.9 5393.1 4658.0 5220.0 5226.9 5311.3 5350.5 4229.0 5154.4 5164.2 5179.6 5257.9 5651.4 5711.9 5749.2 5770.1 5791.9 6105.8 6173.9 6211.6 6211.8 6244.6 6263.6 6283.3 6301.1 6308.0 6318.5 5853.0 5939.6 5946.1 5955.9 5966.0 6295.2 6359.4 6384.3 6387.2 6397.6 6190.1 6259.3 6259.3 6263.0 6294.7 6149.2 6199.5 6213.9 6281.0 6308.3 6240.2 6280.7 6307.1 6308.2 6314.0 6266.8 6268.7 6271.7 6285.8 6340.4 4922.2 4940.2 4948.8 4997.3 5037.0 4440.3 4445.2 4466.9 4500.1 4537.6 5056.3 5290.8 5516.8 5915.0 6017.2 6188.9 6261.2 6284.0 6292.5 6302.9 5877.2 5947.7 5959.8 6011.9 6069.5 5478.8 5482.6 5495.0 5498.4 5515.6 5476.5 6448.3 6512.1 6534.0 6552.3 6126.1 6183.9 6223.2 6231.8 6256.0 5394.6 6480.6 6494.9 6507.9 6521.4 6215.8 6246.2 6278.8 6279.6 6289.9 6123.7 6132.3 6194.3 6229.9 6298.4 5147.9 6187.2 6219.8 6220.4 6229.9 6199.5 6204.5 6212.6 6213.7 6226.7 5248.4 5995.9 6039.2 6055.5 6106.1 6138.5 6183.3 6207.2 6218.4 6219.7 6050.1 6091.7 6100.3 6112.3 6139.1 14:24:52 INFO - PROCESS | 1940 | 14:24:52 INFO - PROCESS | 1940 | [#1] ext.html Cycles:180 Average:68527.95 Median:38907.98 stddev:154183.70 (396.3%) stddev-sans-first:154531.55 14:24:52 INFO - PROCESS | 1940 | Values: 473.1 493.1 509.0 523.6 548.2 32785.7 40028.6 40151.8 40300.8 40391.6 41080.6 41556.4 41570.0 41580.8 41587.6 9653.8 9824.0 9886.9 9889.0 9889.6 9765.5 9782.7 9845.0 9860.1 9869.0 9836.5 9841.2 9849.0 9852.0 9852.1 9790.1 9812.2 9822.9 9841.4 9870.2 9737.2 9781.6 9807.4 9811.8 9830.4 38956.4 39409.4 39679.8 39696.6 39775.6 3169.0 3343.6 3431.7 3716.8 3767.5 30015.9 30061.8 31125.4 31992.8 32195.8 3232.7 3309.9 3348.2 3439.3 3466.3 491255.0 502974.0 504448.0 505676.5 506077.0 28247.3 32809.0 46446.0 53253.5 56904.4 34731.1 34976.7 35091.8 35103.8 35293.8 14765.7 14850.3 14869.6 14873.9 15102.3 12521.3 12555.3 12653.5 12667.7 12712.3 7555.0 7672.9 7679.6 7741.1 7748.3 3094.8 3270.0 3270.0 3277.0 3308.3 927.7 973.9 1039.0 1040.6 1082.6 29221.4 29436.0 30170.4 30464.8 30548.4 1056.7 1127.8 1155.8 1168.3 1185.2 14929.9 15517.9 15531.5 15550.2 15879.9 518600.0 579863.0 677131.6 687435.0 690887.5 54993.9 55181.0 55320.0 55928.7 55942.7 1356.5 1359.6 1379.5 1379.7 1381.5 29119.0 29727.7 29883.6 30083.9 30517.0 44105.0 44199.6 44326.0 45769.5 48681.5 575232.0 580497.0 584419.0 584497.0 586587.0 25642.4 26030.1 26272.3 26289.0 26352.0 44652.6 46358.5 46445.8 46663.3 47094.5 37634.1 38340.6 38929.1 39519.6 39650.4 38161.4 38205.4 38546.2 38618.2 39569.8 37599.8 37849.4 38272.8 38886.8 38971.4 32735.0 34022.1 34184.0 34909.3 35072.9 25471.8 25493.0 25505.0 25650.0 25846.5 14:24:52 INFO - PROCESS | 1940 | 14:24:52 INFO - PROCESS | 1940 | [#2] jquery.html Cycles:180 Average:33909.63 Median:14415.48 stddev:97671.50 (677.5%) stddev-sans-first:97913.04 14:24:52 INFO - PROCESS | 1940 | Values: 380.1 383.1 386.6 392.2 413.0 19128.4 20581.2 20900.3 21497.9 21738.8 20079.4 20435.3 20489.7 20540.4 20865.5 4981.0 5918.3 6046.3 6120.9 6145.9 5873.7 6035.1 6142.7 6159.9 6175.7 5990.5 6025.6 6064.7 6069.0 6069.1 4790.9 5007.0 6015.5 6042.9 6044.5 4385.4 5227.2 5232.4 5244.7 5246.2 22522.5 25130.5 25616.4 25623.0 25839.7 2343.7 2388.6 2464.4 2508.2 2991.3 15015.7 15109.5 15426.6 16232.0 16288.4 1517.6 1844.4 1873.9 1880.3 1904.5 81397.6 108536.5 110777.4 116022.4 122649.4 10359.6 10663.7 10909.4 11023.2 11162.3 11789.5 13164.9 13727.7 13734.8 13755.5 6923.9 7339.3 8745.2 8749.7 8776.6 8766.7 8788.2 8819.6 8893.7 8943.3 6497.5 6560.7 6606.6 6654.3 6748.1 1816.1 1838.8 1852.8 1855.5 1856.3 893.5 904.6 920.5 944.5 947.7 18067.0 20155.0 20744.5 22126.4 22338.6 932.8 943.3 968.9 980.7 997.5 10862.6 11660.8 11685.4 11719.9 11780.9 578046.0 589114.0 590729.0 591211.0 596874.0 101282.0 101722.0 109431.5 112822.7 113996.0 932.1 938.2 945.9 950.1 979.8 18291.4 19237.9 19656.0 19766.4 19794.9 50334.7 50394.0 52307.0 52682.0 53622.5 71358.0 71445.6 74634.6 75662.2 76954.6 7708.5 7824.9 7908.2 7985.5 8114.8 11234.1 11615.7 12163.1 12403.3 13032.9 9725.8 10471.5 10770.7 10874.3 10980.8 10902.7 10961.5 11137.7 11233.0 11283.1 10828.2 10869.7 11027.7 11309.5 11451.3 7725.2 7735.5 7884.8 7957.7 7969.4 8174.7 10279.5 10829.1 11003.7 11168.3 14:24:52 INFO - PROCESS | 1940 | 14:24:52 INFO - PROCESS | 1940 | [#3] mootools.html Cycles:180 Average:5709.93 Median:4795.52 stddev:3209.23 (66.9%) stddev-sans-first:3202.59 14:24:52 INFO - PROCESS | 1940 | Values: 1493.4 1498.1 1723.0 1815.2 1866.2 8007.8 8330.7 8554.4 9163.4 9185.8 8621.7 8929.1 8957.1 9025.9 9028.3 1979.3 2373.3 2390.2 2391.7 2397.0 2349.3 2370.9 2396.2 2397.3 2408.6 2357.8 2369.7 2374.1 2398.9 2401.5 2355.5 2370.4 2371.2 2378.9 2382.7 2367.8 2382.5 2382.6 2384.6 2385.2 8357.8 8376.1 8423.8 8449.3 8961.0 5268.3 5396.6 5411.5 5415.6 5418.1 3573.6 3595.4 3611.2 3618.9 3732.9 1086.7 1090.3 1091.9 1110.2 1124.3 11469.2 11671.0 11674.8 11683.3 11689.9 4562.1 4646.1 4790.0 4801.0 4808.4 9914.2 10067.8 10069.7 10072.0 10115.8 5359.2 5370.4 5386.6 5388.9 5400.2 4351.2 4514.9 4754.4 4892.4 4940.6 3258.0 3939.4 4004.0 4038.3 4051.2 1286.0 1291.8 1296.7 1300.4 1311.2 888.2 888.4 901.7 906.4 915.0 5792.3 5857.0 5948.2 6147.5 6210.4 451.6 452.0 452.8 459.8 467.5 3885.8 3975.3 4077.7 4100.6 4138.7 9452.5 10949.0 10972.1 10976.5 10977.7 10091.1 10695.5 10742.7 10820.9 10913.3 7323.2 8088.8 8198.5 8285.9 8338.7 4818.9 5833.9 5867.9 5920.6 6109.1 9880.4 9954.7 9991.3 10043.1 10084.4 10003.5 10008.7 10225.9 10261.7 10426.3 7015.6 7155.5 7536.8 7551.2 7630.0 7047.3 7102.5 8451.2 8496.8 8512.9 7422.2 7529.8 7575.3 7595.1 7668.0 7350.0 7404.1 7436.9 7492.5 7529.2 7043.3 7056.9 7101.4 7120.3 7124.3 5035.9 5072.6 5078.7 5197.6 5212.8 5035.2 5038.5 5098.6 5137.0 5155.1 14:24:52 INFO - PROCESS | 1940 | 14:24:52 INFO - PROCESS | 1940 | [#4] prototype.html Cycles:180 Average:4529.36 Median:4804.66 stddev:1416.78 (29.5%) stddev-sans-first:1384.09 14:24:52 INFO - PROCESS | 1940 | Values: 262.7 268.9 304.5 316.4 318.2 3901.4 4557.5 5429.8 5492.7 5616.3 3801.3 5397.1 5482.6 5501.2 5564.2 3707.3 4128.6 4229.4 4240.9 4261.0 4048.8 4205.6 4239.6 4242.3 4258.8 3406.6 4128.7 4130.3 4148.9 4179.8 3419.4 4160.7 4163.5 4194.8 4222.0 3643.9 3656.3 3665.5 3669.8 3689.6 4568.0 4723.0 4795.1 4947.1 5274.2 3635.3 4768.5 4779.2 4805.5 4828.6 4809.9 5228.7 5311.8 5748.8 5774.7 3837.2 3983.8 3991.9 3993.3 4010.5 5606.5 5852.7 6087.2 6169.7 6188.8 3374.0 4051.6 4075.9 4076.1 4087.7 3363.6 4054.2 4093.5 4093.5 4111.5 3980.9 4591.6 4677.0 4727.1 4803.8 4644.8 5139.5 5919.9 5921.5 5994.3 1152.9 1299.7 1383.3 1393.3 1395.6 920.5 939.9 944.5 952.0 957.3 4629.6 5051.2 5504.4 5558.1 5583.9 5776.7 6053.6 6065.8 6070.4 6104.5 5408.8 5457.8 5558.0 5564.4 5577.9 2312.6 2643.0 2654.4 2666.5 2684.2 4255.4 4390.0 4774.0 5335.3 5388.9 4218.0 4289.5 4318.5 4443.9 4464.7 4240.8 4584.3 4762.9 5020.0 5358.9 4401.4 5039.7 5153.6 5185.7 5217.6 4848.3 5037.2 5447.8 6031.9 6054.6 5196.7 6426.4 6444.6 6447.7 6474.7 3364.8 3994.9 4027.7 4060.8 4069.9 5085.0 5504.9 5737.8 6013.0 6068.7 4406.5 5652.6 5812.8 5830.2 5944.6 5114.8 5804.1 5885.5 5946.8 5999.7 5600.9 5752.3 5802.3 5806.6 5824.9 5812.4 5899.6 5931.6 5992.3 6005.0 4442.0 4695.8 4957.2 5314.3 5844.7 14:24:52 INFO - PROCESS | 1940 | 14:24:52 INFO - PROCESS | 1940 | [#5] yui.html Cycles:180 Average:24904.24 Median:3687.96 stddev:40485.13 (1097.8%) stddev-sans-first:40558.06 14:24:52 INFO - PROCESS | 1940 | Values: 744.5 762.5 770.5 804.9 832.0 13019.2 13864.8 14548.8 15066.9 15088.2 11102.3 11742.0 13432.0 13517.0 13813.9 806.9 812.4 837.3 837.9 845.1 830.2 831.0 832.5 833.2 834.2 845.2 864.1 877.3 879.4 881.8 819.5 875.6 876.2 877.0 878.7 543.4 638.2 640.6 648.3 650.9 14718.1 14741.4 14826.4 14843.0 14868.3 14022.8 14175.4 14199.4 14353.6 14441.6 11862.0 11978.6 12030.0 12033.2 12231.0 3669.3 3697.9 3750.9 3829.4 3861.6 92008.0 131535.0 131820.0 133897.6 135051.0 10686.1 10973.6 11015.3 11139.5 11170.3 22188.6 22429.8 22528.7 22640.8 22696.7 7966.3 7992.6 8042.5 8157.0 8236.9 3861.2 4458.3 4535.8 4546.8 4563.1 3590.0 3683.4 3692.6 3717.1 3723.8 673.7 679.1 680.6 681.3 692.3 598.5 663.5 675.3 677.7 698.2 8983.0 9398.1 9500.0 9750.0 9801.1 564.5 627.0 640.5 650.2 685.8 4422.0 4565.7 4613.9 4629.3 4773.0 151428.2 154500.2 159859.0 163143.4 163917.0 113097.4 115837.3 117655.0 125054.4 131907.3 87972.6 102384.0 112740.0 115394.4 115580.8 7896.4 9757.2 9821.4 10029.4 10145.4 59673.0 62469.0 62487.1 64156.0 64726.0 69603.3 82680.6 86011.3 87485.3 87885.0 10764.0 12995.9 13223.6 13251.3 13401.5 11783.9 12230.3 14044.8 14907.6 14991.8 11087.9 12596.4 12770.9 13214.4 13590.8 13364.9 13773.8 14120.7 14283.8 14285.4 13055.2 13639.9 13641.8 13675.6 13908.2 8817.8 10751.1 11069.2 11215.1 11582.8 9616.7 10703.8 11498.4 11656.9 11736.5 14:24:52 INFO - PROCESS | 1940 | -------- Summary: end -------- 14:24:52 INFO - PROCESS | 1940 | 14:24:52 INFO - TEST-INFO | 1940: exit 0 14:24:52 INFO - TEST-OK | dromaeo_css | took 1113372ms 14:24:52 INFO - TEST-START | kraken 14:24:52 INFO - operating with platform_type : mac_ 14:24:52 INFO - Initialising browser for kraken test... 14:24:52 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpI2mdmM/profile http://localhost:57281/getInfo.html) 14:24:55 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 14:24:55 INFO - PROCESS | 1945 | colorDepth:24 14:24:55 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 14:24:55 INFO - PROCESS | 1945 | __metrics 14:24:55 ERROR - PROCESS | 1945 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 14:24:56 INFO - TEST-INFO | 1945: exit 0 14:24:56 INFO - Browser initialized. 14:24:56 INFO - Running cycle 1/1 for kraken test... 14:24:56 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpI2mdmM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:08 INFO - PROCESS | 1948 | RSS: Main: 225677312 14:25:08 INFO - PROCESS | 1948 | 14:25:11 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57281/tests/kraken/driver.html?testName=audio-beat-detection) 14:25:12 INFO - PROCESS | 1948 | RSS: Main: 237805568 14:25:12 INFO - PROCESS | 1948 | 14:25:15 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57281/tests/kraken/driver.html?testName=audio-dft) 14:25:15 INFO - PROCESS | 1948 | RSS: Main: 245264384 14:25:15 INFO - PROCESS | 1948 | 14:25:19 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57281/tests/kraken/driver.html?testName=audio-fft) 14:25:19 INFO - PROCESS | 1948 | RSS: Main: 249049088 14:25:19 INFO - PROCESS | 1948 | 14:25:21 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57281/tests/kraken/driver.html?testName=audio-oscillator) 14:25:22 INFO - PROCESS | 1948 | RSS: Main: 249413632 14:25:22 INFO - PROCESS | 1948 | 14:25:24 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:25:24 INFO - PROCESS | 1948 | RSS: Main: 249495552 14:25:24 INFO - PROCESS | 1948 | 14:25:27 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57281/tests/kraken/driver.html?testName=imaging-darkroom) 14:25:28 INFO - PROCESS | 1948 | RSS: Main: 251191296 14:25:28 INFO - PROCESS | 1948 | 14:25:31 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57281/tests/kraken/driver.html?testName=imaging-desaturate) 14:25:31 INFO - PROCESS | 1948 | RSS: Main: 251006976 14:25:31 INFO - PROCESS | 1948 | 14:25:35 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57281/tests/kraken/driver.html?testName=json-parse-financial) 14:25:35 INFO - PROCESS | 1948 | RSS: Main: 251523072 14:25:35 INFO - PROCESS | 1948 | 14:25:37 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:25:37 INFO - PROCESS | 1948 | RSS: Main: 251318272 14:25:37 INFO - PROCESS | 1948 | 14:25:39 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57281/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:25:40 INFO - PROCESS | 1948 | RSS: Main: 251293696 14:25:40 INFO - PROCESS | 1948 | 14:25:42 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:25:43 INFO - PROCESS | 1948 | RSS: Main: 251334656 14:25:43 INFO - PROCESS | 1948 | 14:25:46 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:47 INFO - PROCESS | 1948 | RSS: Main: 251691008 14:25:47 INFO - PROCESS | 1948 | 14:25:50 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:25:50 INFO - PROCESS | 1948 | RSS: Main: 251731968 14:25:50 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | Cycle 1(1): loaded http://localhost:57281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57281/tests/kraken/driver.html?testName=ai-astar) 14:25:52 INFO - PROCESS | 1948 | RSS: Main: 253272064 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | __start_tp_report 14:25:52 INFO - PROCESS | 1948 | _x_x_mozilla_page_load 14:25:52 INFO - PROCESS | 1948 | _x_x_mozilla_page_load_details 14:25:52 INFO - PROCESS | 1948 | |i|pagename|runs| 14:25:52 INFO - PROCESS | 1948 | |0;ai-astar;116;117;119;116;122;96;160;171;98;171 14:25:52 INFO - PROCESS | 1948 | |1;audio-beat-detection;140;113;110;145;110;113;110;121;147;112 14:25:52 INFO - PROCESS | 1948 | |2;audio-dft;193;193;199;201;196;196;200;195;200;193 14:25:52 INFO - PROCESS | 1948 | |3;audio-fft;83;59;58;85;62;60;67;51;80;70 14:25:52 INFO - PROCESS | 1948 | |4;audio-oscillator;85;71;89;71;68;71;88;69;72;90 14:25:52 INFO - PROCESS | 1948 | |5;imaging-gaussian-blur;89;86;91;85;80;124;89;86;88;85 14:25:52 INFO - PROCESS | 1948 | |6;imaging-darkroom;97;97;98;128;174;117;101;99;110;124 14:25:52 INFO - PROCESS | 1948 | |7;imaging-desaturate;91;106;76;105;143;150;99;151;150;91 14:25:52 INFO - PROCESS | 1948 | |8;json-parse-financial;57;56;57;56;54;59;59;54;56;92 14:25:52 INFO - PROCESS | 1948 | |9;json-stringify-tinderbox;69;69;75;114;106;66;70;69;69;72 14:25:52 INFO - PROCESS | 1948 | |10;stanford-crypto-aes;102;105;107;102;88;86;89;86;87;91 14:25:52 INFO - PROCESS | 1948 | |11;stanford-crypto-ccm;160;149;144;157;133;138;159;149;174;165 14:25:52 INFO - PROCESS | 1948 | |12;stanford-crypto-pbkdf2;176;225;178;162;164;167;166;183;162;166 14:25:52 INFO - PROCESS | 1948 | |13;stanford-crypto-sha256-iterative;69;68;67;70;68;68;67;70;70;67 14:25:52 INFO - PROCESS | 1948 | __end_tp_report 14:25:52 INFO - PROCESS | 1948 | __start_cc_report 14:25:52 INFO - PROCESS | 1948 | _x_x_mozilla_cycle_collect,946 14:25:52 INFO - PROCESS | 1948 | __end_cc_report 14:25:52 INFO - PROCESS | 1948 | __startTimestamp1477517152664__endTimestamp 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | ------- Summary: start ------- 14:25:52 INFO - PROCESS | 1948 | Number of tests: 14 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#0] ai-astar Cycles:10 Average:128.60 Median:165.50 stddev:28.22 (17.1%) stddev-sans-first:29.56 14:25:52 INFO - PROCESS | 1948 | Values: 116.0 117.0 119.0 116.0 122.0 96.0 160.0 171.0 98.0 171.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:117.00 stddev:15.54 (13.3%) stddev-sans-first:15.07 14:25:52 INFO - PROCESS | 1948 | Values: 140.0 113.0 110.0 145.0 110.0 113.0 110.0 121.0 147.0 112.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#2] audio-dft Cycles:10 Average:196.60 Median:197.50 stddev:3.17 (1.6%) stddev-sans-first:3.08 14:25:52 INFO - PROCESS | 1948 | Values: 193.0 193.0 199.0 201.0 196.0 196.0 200.0 195.0 200.0 193.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#3] audio-fft Cycles:10 Average:67.50 Median:68.50 stddev:11.69 (17.1%) stddev-sans-first:10.97 14:25:52 INFO - PROCESS | 1948 | Values: 83.0 59.0 58.0 85.0 62.0 60.0 67.0 51.0 80.0 70.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.50 stddev:9.28 (11.8%) stddev-sans-first:9.42 14:25:52 INFO - PROCESS | 1948 | Values: 85.0 71.0 89.0 71.0 68.0 71.0 88.0 69.0 72.0 90.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:87.00 stddev:12.22 (14.0%) stddev-sans-first:12.95 14:25:52 INFO - PROCESS | 1948 | Values: 89.0 86.0 91.0 85.0 80.0 124.0 89.0 86.0 88.0 85.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#6] imaging-darkroom Cycles:10 Average:114.50 Median:135.50 stddev:23.91 (17.6%) stddev-sans-first:24.51 14:25:52 INFO - PROCESS | 1948 | Values: 97.0 97.0 98.0 128.0 174.0 117.0 101.0 99.0 110.0 124.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#7] imaging-desaturate Cycles:10 Average:116.20 Median:113.50 stddev:29.11 (25.6%) stddev-sans-first:29.41 14:25:52 INFO - PROCESS | 1948 | Values: 91.0 106.0 76.0 105.0 143.0 150.0 99.0 151.0 150.0 91.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:57.00 stddev:11.37 (20.0%) stddev-sans-first:12.01 14:25:52 INFO - PROCESS | 1948 | Values: 57.0 56.0 57.0 56.0 54.0 59.0 59.0 54.0 56.0 92.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#9] json-stringify-tinderbox Cycles:10 Average:77.90 Median:69.00 stddev:17.18 (24.9%) stddev-sans-first:17.92 14:25:52 INFO - PROCESS | 1948 | Values: 69.0 69.0 75.0 114.0 106.0 66.0 70.0 69.0 69.0 72.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:86.50 stddev:8.59 (9.9%) stddev-sans-first:8.65 14:25:52 INFO - PROCESS | 1948 | Values: 102.0 105.0 107.0 102.0 88.0 86.0 89.0 86.0 87.0 91.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:158.00 stddev:12.58 (8.0%) stddev-sans-first:13.07 14:25:52 INFO - PROCESS | 1948 | Values: 160.0 149.0 144.0 157.0 133.0 138.0 159.0 149.0 174.0 165.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:171.50 stddev:19.03 (11.1%) stddev-sans-first:20.18 14:25:52 INFO - PROCESS | 1948 | Values: 176.0 225.0 178.0 162.0 164.0 167.0 166.0 183.0 162.0 166.0 14:25:52 INFO - PROCESS | 1948 | 14:25:52 INFO - PROCESS | 1948 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.26 (1.8%) stddev-sans-first:1.32 14:25:52 INFO - PROCESS | 1948 | Values: 69.0 68.0 67.0 70.0 68.0 68.0 67.0 70.0 70.0 67.0 14:25:52 INFO - PROCESS | 1948 | -------- Summary: end -------- 14:25:52 INFO - PROCESS | 1948 | 14:25:53 INFO - TEST-INFO | 1948: exit 0 14:25:53 INFO - TEST-OK | kraken | took 60516ms 14:25:53 INFO - SUITE-END | took 1173s 14:25:53 INFO - Completed test suite (00:19:34) 14:25:53 INFO - javascript benchmark 14:25:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7265.657085922757, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3449.1032331593788, 3453.879114231001, 3464.0820182651587, 3478.843452044657, 3482.2687235680505, 5799.594028418007, 5819.098039803832, 5830.737616807243, 5839.065749480084, 5844.925051606682, 5804.970975145129, 5849.151872978427, 5874.471297583216, 5883.411658834115, 5903.616264942786, 4758.405199350082, 4974.726390048546, 5345.465453454643, 5364.892702145955, 5385.78456861725, 5052.418971818232, 5174.922376164342, 5396.703181325026, 5401.594880383967, 5407.972960135214, 5269.473052694719, 5275.050490911634, 5363.54409875161, 5370.892582148354, 5393.1101368274185, 4657.976710116462, 5220.008198442284, 5226.947730522684, 5311.336082989626, 5350.5452036576935, 4228.978855105735, 5154.355705536808, 5164.225366195101, 5179.559737422323, 5257.921131183035, 5651.434856514356, 5711.914321285184, 5749.195112684228, 5770.076787713946, 5791.942080579224, 6105.763021687103, 6173.9073913891325, 6211.596246243979, 6211.751529938797, 6244.6253224806205, 6263.561550691454, 6283.340249273851, 6301.08634248036, 6307.96846015767, 6318.4629306509005, 5853.0, 5939.554533410012, 5946.07835785454, 5955.940440595626, 5965.970170149165, 6295.24457065146, 6359.395857393541, 6384.32964538726, 6387.201599800025, 6397.552171348054, 6190.133381326528, 6259.280182779039, 6259.3427690091885, 6263.029230469285, 6294.748210071637, 6149.200603921461, 6199.504039676815, 6213.937860621426, 6280.995040793451, 6308.337624549448, 6240.157578726814, 6280.685965701697, 6307.117003619497, 6308.243010838729, 6314.021326694278, 6266.811995640138, 6268.686565671698, 6271.717772700239, 6285.779997700059, 6340.4293613575, 4922.163232250526, 4940.182548083621, 4948.752562371867, 4997.250412438163, 5036.992601479718, 4440.33394990754, 4445.222086134913, 4466.910661786811, 4500.099980004013, 4537.636989040869, 5056.292119103328, 5290.809567847204, 5516.7517461714315, 5914.99445094335, 6017.247844019497, 6188.907166392508, 6261.217347831521, 6284.0, 6292.465140463112, 6302.873942521124, 5877.206577112121, 5947.672877991666, 5959.76160953557, 6011.879762404727, 6069.453749162508, 5478.780848766084, 5482.643628164156, 5495.0, 5498.367687715884, 5515.586331025189, 5476.479734425223, 6448.258450278278, 6512.088307637029, 6534.0, 6552.312007239362, 6126.120738204555, 6183.907241391293, 6223.19098517208, 6231.813045608639, 6255.96872015637, 5394.595405344537, 6480.625701877237, 6494.935050649433, 6507.902381464377, 6521.445677117308, 6215.81352559424, 6246.187995560548, 6278.843028924313, 6279.591826531261, 6289.937100628935, 6123.679189354688, 6132.264128304632, 6194.256689197326, 6229.875402492015, 6298.401651843067, 5147.9227811583605, 6187.16473276102, 6219.844503887439, 6220.440160385587, 6229.906551401823, 6199.473044791062, 6204.5036397089025, 6212.565120441706, 6213.689315534115, 6226.688665566794, 5248.396434410091, 5995.91006134917, 6039.214902062704, 6055.5458340623745, 6106.114613380946, 6138.51101655979, 6183.319834818257, 6207.224096987877, 6218.409251121137, 6219.720112595034, 6050.1227322037175, 6091.664958427329, 6100.2829925465485, 6112.297085835008, 6139.140520327247], "value": 5748.231781713284, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.1058299813352, 493.1271649180952, 508.95164959328866, 523.6099106165907, 548.2078396716746, 32785.67214327856, 40028.59971400285, 40151.79544613659, 40300.798496007475, 40391.59608403915, 41080.58919410805, 41556.37665435013, 41569.96075098124, 41580.79209603948, 41587.58412415875, 9653.806923861519, 9823.95088024559, 9886.851697224547, 9889.0, 9889.554970026365, 9765.462899540522, 9782.706518804413, 9845.0, 9860.063293987096, 9869.0, 9836.458994755285, 9841.21270298378, 9848.950755246215, 9851.95074024629, 9852.113309802116, 9790.069943355405, 9812.165965892944, 9822.901770982271, 9841.409515429097, 9870.161036311922, 9737.172340351079, 9781.608735650565, 9807.362521436084, 9811.803763924752, 9830.361026533252, 38956.415653765216, 39409.40885886714, 39679.8016009921, 39696.60303396987, 39775.60224397748, 3168.9683103168904, 3343.5987681478136, 3431.7083047940955, 3716.758410703296, 3767.472553842464, 30015.949441769433, 30061.849690751624, 31125.37749245025, 31992.840035799672, 32195.83902080498, 3232.7090561849545, 3309.9007029789145, 3348.196432856097, 3439.329330780499, 3466.254755227613, 491255.0, 502974.0, 504447.99999999633, 505676.47161764326, 506077.0, 28247.29381765472, 32809.0, 46446.0, 53253.46746532485, 56904.43095568991, 34731.13172170665, 34976.65023349734, 35091.82454087764, 35103.82448087743, 35293.82353088218, 14765.704685906221, 14850.257487125817, 14869.553913382615, 14873.851261487247, 15102.320395582225, 12521.311327877054, 12555.309457979716, 12653.493860245671, 12667.683307917376, 12712.300823454614, 7555.0, 7672.884906726404, 7679.6160191990175, 7741.07107147146, 7748.302652761278, 3094.845257737104, 3269.9509507357407, 3269.967300327014, 3276.950845737316, 3308.2556424804225, 927.6521304510809, 973.9464329461948, 1039.0129377091794, 1040.5889673579045, 1082.6156714366286, 29221.41557168845, 29436.0, 30170.396592068035, 30464.84767576148, 30548.38903221923, 1056.6738742877792, 1127.8383265236819, 1155.751513424601, 1168.339887963298, 1185.1763024697752, 14929.850701493064, 15517.922410387875, 15531.45639902598, 15550.222488875512, 15879.920600396925, 518600.0, 579863.0, 677131.6143419251, 687435.0, 690887.5455622791, 54993.90012199814, 55181.0, 55320.0, 55928.72035639796, 55942.72028639912, 1356.4980957045957, 1359.64649191211, 1379.4620098161724, 1379.7447472217673, 1381.5233744358181, 29119.0, 29727.70272297249, 29883.55174672338, 30083.94706185273, 30517.0, 44105.0, 44199.55800442083, 44326.0, 45769.54230457653, 48681.513184869116, 575232.0, 580497.0, 584419.0, 584497.0, 586587.0, 25642.358941025876, 26030.088946886768, 26272.34319142037, 26289.0, 26352.0, 44652.55347446614, 46358.53641463542, 46445.838854028916, 46663.30005049995, 47094.52905470901, 37634.05914852041, 38340.61659383482, 38929.1200351105, 39519.604803951595, 39650.40524392194, 38161.427578586896, 38205.4269185968, 38546.229075418894, 38618.22763544657, 39569.80215098906, 37599.81200093982, 37849.432258516696, 38272.808635956644, 38886.8333949982, 38971.415428769156, 32735.0, 34022.14944626404, 34184.0, 34909.301813964084, 35072.9478115657, 25471.773230352705, 25493.0, 25505.0, 25650.0, 25846.483070338112], "value": 18571.98276232816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.1124374585343, 383.1035377217311, 386.5554612195974, 392.2273121949758, 412.97522148671084, 19128.42614721557, 20581.176752929903, 20900.268490602833, 21497.892510537466, 21738.782612173894, 20079.397618071445, 20435.284765033226, 20489.692654610193, 20540.383788486368, 20865.478363040933, 4981.0, 5918.260217472816, 6046.33490316067, 6120.938790612104, 6145.938540614604, 5873.7356818943035, 6035.124906888521, 6142.692865356737, 6159.9384006160035, 6175.66033868137, 5990.520758339322, 6025.638461692291, 6064.72708728106, 6068.969655151718, 6069.0592958091565, 4790.856274311776, 5006.973570418056, 6015.54883383748, 6042.879142417149, 6044.5164386849165, 4385.3641222022625, 5227.189785583203, 5232.372115346183, 5244.737763111829, 5246.23929530216, 22522.54954900909, 25130.49739005228, 25616.359591010187, 25622.975080996737, 25839.708014599382, 2343.7304709958403, 2388.605880029793, 2464.445499762539, 2508.1723031399592, 2991.2521869532616, 15015.699686006219, 15109.471168509159, 15426.614334641612, 16232.0, 16288.429904953387, 1517.5674932644254, 1844.3729132095152, 1873.878197917131, 1880.3042874136656, 1904.4953087431702, 81397.59301203515, 108536.4573177129, 110777.44611276891, 116022.41988790002, 122649.38675306566, 10359.585616575403, 10663.73340666474, 10909.39998300101, 11023.228374013903, 11162.330260184415, 11789.528418863321, 13164.946804255636, 13727.725445491034, 13734.793978090336, 13755.518556850462, 6923.861522769516, 7339.339459448675, 8745.212930836255, 8749.737507874774, 8776.648934042694, 8766.693165739169, 8788.209061184523, 8819.559022048872, 8893.688720894737, 8943.284537237136, 6497.480201583862, 6560.737570497222, 6606.6036037837885, 6654.26803051664, 6748.089007983957, 1816.1464111867401, 1838.8069252728271, 1852.7961924188328, 1855.5082903030707, 1856.2574970011833, 893.5487578772678, 904.5703290936752, 920.5213289089636, 944.5466176235308, 947.7014740356766, 18067.00631465282, 20155.0, 20744.48138796512, 22126.446838829157, 22338.553228935656, 932.7947851472666, 943.2501161576563, 968.8692026576463, 980.6665733650593, 997.5411310797115, 10862.565497380174, 11660.825087623693, 11685.357305348118, 11719.941400293115, 11780.939715425482, 578046.0, 589114.0, 590729.0, 591211.0, 596874.0312596818, 101282.0, 101721.98278017274, 109431.45284273528, 112822.70959000917, 113996.0, 932.1191474056951, 938.2494004796272, 945.9101385368378, 950.0689324462066, 979.8481235408523, 18291.359802406852, 19237.903810480857, 19656.0171991397, 19766.40700778979, 19794.90102549478, 50334.74832625814, 50394.0, 52307.0, 52682.0, 53622.46377536331, 71358.0, 71445.57108857897, 74634.62682686551, 75662.24337756552, 76954.61522692574, 7708.49894756839, 7824.92175078242, 7908.209179082046, 7985.5208687478935, 8114.837703245784, 11234.101271898391, 11615.6515304541, 12163.148579599698, 12403.317817520123, 13032.869671303166, 9725.756856078371, 10471.528781204712, 10770.73073173177, 10874.34753914736, 10980.835287470534, 10902.727431813952, 10961.45192740344, 11137.721556961142, 11233.045191158517, 11283.097352211638, 10828.187885908746, 10869.728256793644, 11027.739313440887, 11309.491072901903, 11451.25566838153, 7725.188855170126, 7735.535867847947, 7884.763457096296, 7957.681692732457, 7969.402294827795, 8174.67301307941, 10279.486025698536, 10829.133669306595, 11003.724906877393, 11168.329900206014], "value": 9604.943701289874, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.3727834309589, 1498.1235976953478, 1723.0351003438075, 1815.1559524820955, 1866.1882081294639, 8007.799805004864, 8330.708425205119, 8554.358423118269, 9163.404378715379, 9185.816283674323, 8621.741347759562, 8929.062448442917, 8957.10428957104, 9025.864612030808, 9028.32287578431, 1979.2874565156533, 2373.264288070695, 2390.2231774673214, 2391.7129944406697, 2396.9760302397012, 2349.3304408243653, 2370.9407264818346, 2396.18529699902, 2397.2688330059327, 2408.5664580375524, 2357.7642235776457, 2369.680093187415, 2374.1097088591778, 2398.8560686358787, 2401.5076909233567, 2355.5171189906027, 2370.4429459077105, 2371.2412028150998, 2378.9048438062455, 2382.725986511556, 2367.8342516023886, 2382.487765130505, 2382.559226543078, 2384.5588566115325, 2385.2009576791797, 8357.791055223608, 8376.120507346763, 8423.83152336956, 8449.281811046068, 8960.955195223982, 5268.341457317835, 5396.5952553558245, 5411.458854114597, 5415.620906536544, 5418.106012507971, 3573.6426357364317, 3595.3708101082207, 3611.1513794258326, 3618.8552457901915, 3732.9066773330615, 1086.6794295682791, 1090.3076546393097, 1091.9344839309667, 1110.1673744691482, 1124.280460505269, 11469.197156199069, 11671.007964323042, 11674.766504669944, 11683.299002059903, 11689.941550292278, 4562.061124022343, 4646.070785842845, 4789.994101238709, 4801.039792041605, 4808.35087263215, 9914.206863450907, 10067.798644027225, 10069.69790906274, 10072.043155900177, 10115.848262276071, 5359.249705041298, 5370.4361042090795, 5386.649867758583, 5388.91916621251, 5400.21696853954, 4351.216780979391, 4514.88712782183, 4754.405699287589, 4892.412910450697, 4940.629452791055, 3257.951130733041, 3939.4484772131923, 4003.9990002499376, 4038.293298672779, 4051.230266249403, 1286.003347405768, 1291.838520184977, 1296.6887946892866, 1300.440810451496, 1311.1608570514877, 888.1695614600369, 888.3870129610548, 901.6573701993201, 906.410832958569, 914.9679761208325, 5792.304923409133, 5857.0, 5948.226730525004, 6147.508199344042, 6210.441060304594, 451.62289488276997, 451.988700282489, 452.8279253883569, 459.79998700565363, 467.5161208149549, 3885.756557901501, 3975.3043217436834, 4077.673786097105, 4100.5899410058755, 4138.710290279651, 9452.52737363129, 10949.0, 10972.122230221563, 10976.506057227443, 10977.670669879917, 10091.091801737879, 10695.465226738632, 10742.677719668422, 10820.945895270474, 10913.345199288067, 7323.157836848724, 8088.797780055545, 8198.549079800548, 8285.917140828515, 8338.708145214767, 4818.903621927612, 5833.912491312549, 5867.9413205869105, 5920.615160014585, 6109.144719739329, 9880.40717556949, 9954.651587194414, 9991.300608957594, 10043.096121349114, 10084.445355505517, 10003.499825008867, 10008.749781255527, 10225.897741022494, 10261.692149235534, 10426.270161088954, 7015.614141222078, 7155.499115061895, 7536.849263014599, 7551.169371369255, 7630.0, 7047.330503602149, 7102.5028248022145, 8451.197136272045, 8496.787580310542, 8512.914870851213, 7422.220666829905, 7529.811754705957, 7575.318221360104, 7595.126560445619, 7668.0, 7349.963250183715, 7404.148522919718, 7436.888446673413, 7492.475526713078, 7529.209433009674, 7043.2604576518725, 7056.894146587908, 7101.360877521048, 7120.252373500708, 7124.323189297009, 5035.866929940734, 5072.5688316493515, 5078.720670363018, 5197.558207552401, 5212.817551385683, 5035.244713293036, 5038.521340472649, 5098.643094983464, 5136.9743151284, 5155.072087024371], "value": 4522.7117173798415, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.68215459294254, 268.9193242027392, 304.54622612307656, 316.4035792531078, 318.20766291933063, 3901.414787781834, 4557.544245575441, 5429.755660995254, 5492.747973330936, 5616.269884914966, 3801.2777572261252, 5397.055515284829, 5482.616216864821, 5501.174823776426, 5564.221009058725, 3707.3141468828217, 4128.58714128587, 4229.386738922854, 4240.915181696364, 4261.0, 4048.817803198848, 4205.642520385755, 4239.576042395766, 4242.321228603424, 4258.765767882765, 3406.5571475708125, 4128.669706423494, 4130.339145736668, 4148.917021659565, 4179.832806687728, 3419.384510788057, 4160.708750387459, 4163.458750362433, 4194.8112334945, 4221.957780422218, 3643.927121457556, 3656.3235801376563, 3665.4685070664605, 3669.7798132111893, 3689.594144644087, 4567.995041090955, 4722.976385118052, 4795.064962332347, 4947.109520286347, 5274.180407759355, 3635.291118231946, 4768.47546769855, 4779.235322348442, 4805.519448055202, 4828.589569886564, 4809.927851082237, 5228.660137091077, 5311.804843910128, 5748.798792042258, 5774.7478483391515, 3837.194189220267, 3983.820728067244, 3991.9201615967518, 3993.3211354069585, 4010.453362115078, 5606.505105228175, 5852.707364631751, 6087.178230938855, 6169.722362493699, 6188.84527886802, 3373.983130084334, 4051.6150965658217, 4075.918481630351, 4076.144009757984, 4087.734297270668, 3363.5963684358035, 4054.2499637567144, 4093.488313960755, 4093.5087789465456, 4111.546301107024, 3980.900477488028, 4591.563801438858, 4677.0, 4727.125481785881, 4803.807847686124, 4644.790984405709, 5139.486051394905, 5919.881602367928, 5921.496672782776, 5994.250718660168, 1152.8731839497648, 1299.740051989606, 1383.273781264844, 1393.303348325837, 1395.5813256023152, 920.4661296448044, 939.9389039712534, 944.4758159221698, 952.0, 957.3298690916387, 4629.560191781776, 5051.236828562744, 5504.449555044544, 5558.110702287696, 5583.944160558423, 5776.740046697909, 6053.606515576562, 6065.848353791102, 6070.423309785563, 6104.511639068953, 5408.810691625774, 5457.836264912059, 5558.0269004503625, 5564.387917329091, 5577.908284393353, 2312.583734927729, 2642.973570264273, 2654.376221587925, 2666.4800363929235, 2684.1813246959864, 4255.404243405926, 4390.034192477649, 4773.952260477351, 5335.33308336458, 5388.8952764683145, 4217.957820421818, 4289.485261768607, 4318.546552611993, 4443.911121777546, 4464.718431952512, 4240.787960601958, 4584.335271385564, 4762.903902643724, 5019.970905964342, 5358.8660283492445, 4401.371492547778, 5039.722815245197, 5153.613478989016, 5185.688858668492, 5217.6086793491395, 4848.3454733610515, 5037.244413338029, 5447.836564903059, 6031.909521357095, 6054.576179667381, 5196.68819870809, 6426.3573642635365, 6444.581102228341, 6447.710457908343, 6474.676266186578, 3364.8317584121187, 3994.920101597894, 4027.7381970171846, 4060.837566497307, 4069.89825254371, 5085.0, 5504.9449505504435, 5737.770489180386, 6012.969935150296, 6068.7269072892705, 4406.493253275914, 5652.604317697722, 5812.82561523155, 5830.2129212555765, 5944.603018290784, 5114.820981265638, 5804.1293805929445, 5885.528617845539, 5946.791862284799, 5999.670018149044, 5600.915986260291, 5752.338481074563, 5802.274715660543, 5806.564507662027, 5824.94175058244, 5812.389699081536, 5899.557533185114, 5931.6441013539325, 5992.340842507234, 6004.979153543995, 4441.977790111029, 4695.788689509049, 4957.206846904478, 5314.335708036496, 5844.678542680023], "value": 4084.8683648249307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.4677055905029, 762.4929421934414, 770.5376773935636, 804.8631732605456, 832.0306842528456, 13019.218846869182, 13864.792028119573, 14548.781768273471, 15066.924665376686, 15088.245587720598, 11102.333859968387, 11742.001929835953, 13432.0, 13517.0, 13813.861861381383, 806.8749343851698, 812.4475356757403, 837.3175861672747, 837.9497230166179, 845.0873057098319, 830.2320353672859, 831.0110967948152, 832.5337810825927, 833.2417500074934, 834.2366734437982, 845.1970627903486, 864.0624921959682, 877.3419935048713, 879.3536750488386, 881.8060026794095, 819.5328662662284, 875.5753459572103, 876.2201640539924, 876.9561521923911, 878.6573236437795, 543.3941155611504, 638.2277444292412, 640.6412409050946, 648.3354561574424, 650.9479241660656, 14718.116912985255, 14741.410343586243, 14826.406943722239, 14843.0, 14868.256587170597, 14022.789658155136, 14175.432982680784, 14199.361028753627, 14353.64115897111, 14441.638959026004, 11861.975196324967, 11978.64064078079, 12030.0, 12033.217840840405, 12230.960368368611, 3669.321175582499, 3697.9445308320396, 3750.8687195948282, 3829.3872980323013, 3861.6331448512346, 92008.0, 131535.0, 131820.0, 133897.6356300403, 135051.0, 10686.0916822071, 10973.615923442801, 11015.266720930713, 11139.498722557504, 11170.329780213213, 22188.55622887533, 22429.775702243096, 22528.662070068964, 22640.773592264195, 22696.65955010676, 7966.322862556632, 7992.600369981594, 8042.517448953082, 8157.0, 8236.917630823735, 3861.2277544490653, 4458.308962110878, 4535.841245556389, 4546.772661366985, 4563.110193512233, 3590.030691713223, 3683.355412802749, 3692.5568931727826, 3717.107894105395, 3723.8138093095235, 673.7170388436869, 679.1137565477001, 680.618853442074, 681.2914568848342, 692.2731132311154, 598.5032423088912, 663.5288944849115, 675.2786271326562, 677.6814896998403, 698.1726653915127, 8982.955085224663, 9398.107179817905, 9500.0, 9750.0, 9801.11789938909, 564.5314389057073, 626.9843253918598, 640.5260107520402, 650.2392201124695, 685.7702669605738, 4421.955780442155, 4565.726056436624, 4613.907721845611, 4629.259318509023, 4772.976135119302, 151428.242858785, 154500.2274988618, 159859.0, 163143.36856631518, 163917.0, 113097.4345128269, 115837.26244106345, 117655.0, 125054.37472812578, 131907.34046329898, 87972.5601371989, 102384.0, 112740.0, 115394.423027886, 115580.84419155869, 7896.447248692766, 9757.21942244633, 9821.36161149523, 10029.398236105857, 10145.391276523433, 59673.0, 62469.0, 62487.062694060536, 64156.0, 64726.02910956245, 69603.30396695968, 82680.58659706663, 86011.27977440291, 87485.25029499501, 87885.0, 10764.03123718869, 12995.870041299466, 13223.603291901258, 13251.337433128498, 13401.53094641683, 11783.88216117862, 12230.327331996825, 14044.78932815988, 14907.627309317353, 14991.77512337294, 11087.944560277147, 12596.370181490705, 12770.87229127734, 13214.405351759386, 13590.796138058135, 13364.933175334061, 13773.793393099311, 14120.717585648435, 14283.785743213652, 14285.428582856985, 13055.151415157985, 13639.931800340935, 13641.79537306961, 13675.589732308046, 13908.235047072509, 8817.814975339805, 10751.13990880712, 11069.225154239448, 11215.102791776475, 11582.826257605973, 9616.711498655051, 10703.785924281627, 11498.425078745862, 11656.941715291368, 11736.530538778354], "value": 7764.996594552477, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 119.0, 116.0, 122.0, 96.0, 160.0, 171.0, 98.0, 171.0], "value": 128.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 113.0, 110.0, 145.0, 110.0, 113.0, 110.0, 121.0, 147.0, 112.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 193.0, 199.0, 201.0, 196.0, 196.0, 200.0, 195.0, 200.0, 193.0], "value": 196.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 58.0, 85.0, 62.0, 60.0, 67.0, 51.0, 80.0, 70.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 89.0, 71.0, 68.0, 71.0, 88.0, 69.0, 72.0, 90.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 91.0, 85.0, 80.0, 124.0, 89.0, 86.0, 88.0, 85.0], "value": 90.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 98.0, 128.0, 174.0, 117.0, 101.0, 99.0, 110.0, 124.0], "value": 114.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 106.0, 76.0, 105.0, 143.0, 150.0, 99.0, 151.0, 150.0, 91.0], "value": 116.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 56.0, 54.0, 59.0, 59.0, 54.0, 56.0, 92.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 75.0, 114.0, 106.0, 66.0, 70.0, 69.0, 69.0, 72.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 105.0, 107.0, 102.0, 88.0, 86.0, 89.0, 86.0, 87.0, 91.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 149.0, 144.0, 157.0, 133.0, 138.0, 159.0, 149.0, 174.0, 165.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 225.0, 178.0, 162.0, 164.0, 167.0, 166.0, 183.0, 162.0, 166.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 70.0, 68.0, 68.0, 67.0, 70.0, 70.0, 67.0], "value": 68.4, "unit": "score"}]}]} 14:25:53 INFO - Return code: 0 14:25:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:25:53 ERROR - # TBPL SUCCESS # 14:25:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:25:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:25:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:25:53 INFO - 2016-10-26 14:25:53.970 screenresolution[1953:21450] starting screenresolution argv=screenresolution get 14:25:53 INFO - 2016-10-26 14:25:53.973 screenresolution[1953:21450] Display 0: 1600x1200x32@60 14:25:53 INFO - 2016-10-26 14:25:53.979 screenresolution[1954:21453] starting screenresolution argv=screenresolution list 14:25:53 INFO - Available Modes on Display 0 14:25:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:25:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:25:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:25:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:25:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:25:54 INFO - Intel Iris: 14:25:54 INFO - Chipset Model: Intel Iris 14:25:54 INFO - Type: GPU 14:25:54 INFO - Bus: Built-In 14:25:54 INFO - VRAM (Dynamic, Max): 1536 MB 14:25:54 INFO - Vendor: Intel (0x8086) 14:25:54 INFO - Device ID: 0x0a2e 14:25:54 INFO - Revision ID: 0x0009 14:25:54 INFO - Displays: 14:25:54 INFO - Display: 14:25:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:25:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:25:54 INFO - Display Serial Number: 1600x1200 60 14:25:54 INFO - Main Display: Yes 14:25:54 INFO - Mirror: Off 14:25:54 INFO - Online: Yes 14:25:54 INFO - Rotation: Supported 14:25:54 INFO - Return code: 0 14:25:54 INFO - Running post-action listener: _resource_record_post_action 14:25:54 INFO - [mozharness: 2016-10-26 21:25:54.213625Z] Finished run-tests step (success) 14:25:54 INFO - Running post-run listener: _resource_record_post_run 14:25:54 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 1089536; Write bytes: 665243648; Read time: 12; Write time: 2047 14:25:54 INFO - TinderboxPrint: CPU usage
54.2% 14:25:54 INFO - TinderboxPrint: I/O read bytes / time
1,089,536 / 12 14:25:54 INFO - TinderboxPrint: I/O write bytes / time
665,243,648 / 2,047 14:25:54 INFO - TinderboxPrint: CPU idle
2,213.7 (45.8%) 14:25:54 INFO - TinderboxPrint: CPU system
974.7 (20.2%) 14:25:54 INFO - TinderboxPrint: CPU user
1,641.3 (34.0%) 14:25:54 INFO - TinderboxPrint: Swap in / out
364,515,328 / 0 14:25:54 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360497664; Write bytes: 356972032; Read time: 27575; Write time: 675 14:25:54 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 245760; Write bytes: 296999424; Read time: 7; Write time: 1292 14:25:54 INFO - Running post-run listener: _upload_blobber_files 14:25:54 INFO - Blob upload gear active. 14:25:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:25:54 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 14:25:54 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'] 14:25:54 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 14:25:55 INFO - (blobuploader) - INFO - Open directory for files ... 14:25:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:25:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:25:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:55 INFO - (blobuploader) - INFO - Done attempting. 14:25:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:25:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:25:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:56 INFO - (blobuploader) - INFO - Done attempting. 14:25:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:25:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:59 INFO - (blobuploader) - INFO - Done attempting. 14:25:59 INFO - (blobuploader) - INFO - Iteration through files over. 14:25:59 INFO - Return code: 0 14:25:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:25:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:25:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/226e226a7b98ae551b04b492a2f23537da8aad73122df920e8c2f0579fe5b62d836f8cf91a1f68bccd1c6df1da8babd3c611c89ed4f10b37757fdee75f781b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1177ce2104636cf8115da9dd95d7cd98d95a1811d538d2d2a0fddcef654668d97347a5ab208a5ff38d4fd2d85bc8831ff0fe54fa973dc5d8c5f5989a7031938f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9dbbd3e7dcd532a05fe66a4ef716b2563f4d0239df1092f5cf3cd99e29f5e5096c91502a82b01c202fde24d5a45ab76c594a13ca8a59b4275a33a13041571ec1"} 14:25:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:25:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:25:59 INFO - Contents: 14:25:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/226e226a7b98ae551b04b492a2f23537da8aad73122df920e8c2f0579fe5b62d836f8cf91a1f68bccd1c6df1da8babd3c611c89ed4f10b37757fdee75f781b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1177ce2104636cf8115da9dd95d7cd98d95a1811d538d2d2a0fddcef654668d97347a5ab208a5ff38d4fd2d85bc8831ff0fe54fa973dc5d8c5f5989a7031938f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9dbbd3e7dcd532a05fe66a4ef716b2563f4d0239df1092f5cf3cd99e29f5e5096c91502a82b01c202fde24d5a45ab76c594a13ca8a59b4275a33a13041571ec1"} 14:25:59 INFO - Running post-run listener: copy_logs_to_upload_dir 14:25:59 INFO - Copying logs to upload dir... 14:25:59 INFO - mkdir: /builds/slave/test/build/upload/logs 14:25:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.056700 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-26 14:25:59.751013) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:59.754501) ========= 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.msVL0oheYJ/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.i9lVXSo0kx/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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/226e226a7b98ae551b04b492a2f23537da8aad73122df920e8c2f0579fe5b62d836f8cf91a1f68bccd1c6df1da8babd3c611c89ed4f10b37757fdee75f781b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1177ce2104636cf8115da9dd95d7cd98d95a1811d538d2d2a0fddcef654668d97347a5ab208a5ff38d4fd2d85bc8831ff0fe54fa973dc5d8c5f5989a7031938f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9dbbd3e7dcd532a05fe66a4ef716b2563f4d0239df1092f5cf3cd99e29f5e5096c91502a82b01c202fde24d5a45ab76c594a13ca8a59b4275a33a13041571ec1"} build_url:https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/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/226e226a7b98ae551b04b492a2f23537da8aad73122df920e8c2f0579fe5b62d836f8cf91a1f68bccd1c6df1da8babd3c611c89ed4f10b37757fdee75f781b15", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1177ce2104636cf8115da9dd95d7cd98d95a1811d538d2d2a0fddcef654668d97347a5ab208a5ff38d4fd2d85bc8831ff0fe54fa973dc5d8c5f5989a7031938f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9dbbd3e7dcd532a05fe66a4ef716b2563f4d0239df1092f5cf3cd99e29f5e5096c91502a82b01c202fde24d5a45ab76c594a13ca8a59b4275a33a13041571ec1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:59.787390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:59.787708) ========= 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.msVL0oheYJ/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.i9lVXSo0kx/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005061 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:59.836008) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:25:59.836380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:25:59.836726) ========= ========= Total master_lag: 0.18 =========