builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0163 starttime: 1477515830.4 results: success (0) buildid: 20161026004014 builduid: 0ff6334abedd49bb95ab30a9518c83be revision: a16ab27e533088e1711a82ff380d3ebd262ca837 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:50.399245) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:50.399697) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:50.400005) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:50.424945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:50.425371) ========= 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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:03:50-- 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% 8.67M=0.001s 2016-10-26 14:03:50 (8.67 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091570 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:50.539590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:50.539913) ========= 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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.030213 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:50.591483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 14:03:50.591829) ========= 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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:03:50,667 truncating revision to first 12 chars 2016-10-26 14:03:50,667 Setting DEBUG logging. 2016-10-26 14:03:50,667 attempt 1/10 2016-10-26 14:03:50,667 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:03:51,845 unpacking tar archive at: mozilla-aurora-a16ab27e5330/testing/mozharness/ program finished with exit code 0 elapsedTime=1.440961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 14:03:52.054328) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:52.054650) ========= script_repo_revision: a16ab27e533088e1711a82ff380d3ebd262ca837 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:52.055067) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:52.055345) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 14:03:52.073445) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-26 14:03:52.073794) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lYIYGjKtx9/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.nFO9CYDjP2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:03:52 INFO - MultiFileLogger online at 20161026 14:03:52 in /builds/slave/test 14:03:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:03:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:03:52 INFO - {'append_to_log': False, 14:03:52 INFO - 'base_work_dir': '/builds/slave/test', 14:03:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:03:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:03:52 INFO - 'branch': 'Mozilla-Aurora', 14:03:52 INFO - 'buildbot_json_path': 'buildprops.json', 14:03:52 INFO - 'config_files': ('talos/mac_config.py',), 14:03:52 INFO - 'default_actions': ('clobber', 14:03:52 INFO - 'read-buildbot-config', 14:03:52 INFO - 'download-and-extract', 14:03:52 INFO - 'populate-webroot', 14:03:52 INFO - 'create-virtualenv', 14:03:52 INFO - 'install', 14:03:52 INFO - 'run-tests'), 14:03:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:03:52 INFO - 'download_minidump_stackwalk': True, 14:03:52 INFO - 'download_symbols': 'ondemand', 14:03:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:03:52 INFO - 'tooltool.py': '/tools/tooltool.py', 14:03:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:03:52 INFO - '/tools/misc-python/virtualenv.py')}, 14:03:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:03:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:03:52 INFO - 'installer_path': 'installer.exe', 14:03:52 INFO - 'log_level': 'info', 14:03:52 INFO - 'log_name': 'talos', 14:03:52 INFO - 'log_to_console': True, 14:03:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:03:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:03:52 INFO - 'opt_config_files': (), 14:03:52 INFO - 'pip_index': False, 14:03:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:03:52 INFO - 'cmd': ('bash', 14:03:52 INFO - '-c', 14:03:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:03:52 INFO - 'enabled': True, 14:03:52 INFO - 'halt_on_failure': False, 14:03:52 INFO - 'name': 'check_screen_resolution'},), 14:03:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:03:52 INFO - 'cmd': ('bash', 14:03:52 INFO - '-c', 14:03:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:03:52 INFO - 'enabled': True, 14:03:52 INFO - 'halt_on_failure': False, 14:03:52 INFO - 'name': 'check_screen_resolution'},), 14:03:52 INFO - 'run_cmd_checks_enabled': True, 14:03:52 INFO - 'sps_profile': False, 14:03:52 INFO - 'sps_profile_interval': 0, 14:03:52 INFO - 'suite': 'dromaeojs', 14:03:52 INFO - 'system_bits': '32', 14:03:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:03:52 INFO - 'title': 't-yosemite-r7-0163', 14:03:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:03:52 INFO - 'use_talos_json': True, 14:03:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:03:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:03:52 INFO - 'work_dir': 'build'} 14:03:52 INFO - [mozharness: 2016-10-26 21:03:52.273215Z] Running clobber step. 14:03:52 INFO - Running pre-action listener: _resource_record_pre_action 14:03:52 INFO - Running main action method: clobber 14:03:52 INFO - rmtree: /builds/slave/test/build 14:03:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:03:54 INFO - Running post-action listener: _resource_record_post_action 14:03:54 INFO - [mozharness: 2016-10-26 21:03:54.370758Z] Finished clobber step (success) 14:03:54 INFO - [mozharness: 2016-10-26 21:03:54.370912Z] Running read-buildbot-config step. 14:03:54 INFO - Running pre-action listener: _resource_record_pre_action 14:03:54 INFO - Running main action method: read_buildbot_config 14:03:54 INFO - Using buildbot properties: 14:03:54 INFO - { 14:03:54 INFO - "project": "", 14:03:54 INFO - "product": "firefox", 14:03:54 INFO - "script_repo_revision": "production", 14:03:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 14:03:54 INFO - "repository": "", 14:03:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 14:03:54 INFO - "buildid": "20161026004014", 14:03:54 INFO - "stage_platform": "macosx64", 14:03:54 INFO - "basedir": "/builds/slave/test", 14:03:54 INFO - "nightly_build": "True", 14:03:54 INFO - "buildnumber": 5, 14:03:54 INFO - "slavename": "t-yosemite-r7-0163", 14:03:54 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:03:54 INFO - "platform": "yosemite_r7", 14:03:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:03:54 INFO - "branch": "mozilla-aurora", 14:03:54 INFO - "repo_path": "releases/mozilla-aurora", 14:03:54 INFO - "revision": "a16ab27e533088e1711a82ff380d3ebd262ca837", 14:03:54 INFO - "pgo_build": "False", 14:03:54 INFO - "builduid": "0ff6334abedd49bb95ab30a9518c83be", 14:03:54 INFO - "slavebuilddir": "test" 14:03:54 INFO - } 14:03:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 14:03:54 INFO - Running post-action listener: _resource_record_post_action 14:03:54 INFO - [mozharness: 2016-10-26 21:03:54.374584Z] Finished read-buildbot-config step (success) 14:03:54 INFO - [mozharness: 2016-10-26 21:03:54.374693Z] Running download-and-extract step. 14:03:54 INFO - Running pre-action listener: _resource_record_pre_action 14:03:54 INFO - Running main action method: download_and_extract 14:03:54 INFO - mkdir: /builds/slave/test/build/tests 14:03: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:03:54 INFO - trying https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 14:03: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:03: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:03:55 INFO - Downloaded 1199 bytes. 14:03:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:03:55 INFO - Using the following test package requirements: 14:03:55 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:03:55 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:55 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 14:03:55 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:55 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 14:03:55 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:55 INFO - u'jsshell-mac.zip'], 14:03:55 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:55 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 14:03:55 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:03:55 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:55 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 14:03:55 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:55 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 14:03:55 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:55 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 14:03:55 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:03:55 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 14:03:55 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:03:55 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:03:55 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:03:55 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:03:56 INFO - Expected file size: 16420194 14:04:03 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:04:03 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:03 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:03 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:03 INFO - Expected file size: 16420194 14:04:10 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:04:10 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:04:10 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:04:11 INFO - Expected file size: 14414081 14:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:11 INFO - trying https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:04:11 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:04:11 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:04:14 INFO - Downloaded 115527563 bytes. 14:04:14 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:04:14 INFO - mkdir: /builds/slave/test/properties 14:04:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:04:14 INFO - Writing to file /builds/slave/test/properties/build_url 14:04:14 INFO - Contents: 14:04:14 INFO - build_url:https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:04:15 INFO - Running post-action listener: _resource_record_post_action 14:04:15 INFO - Running post-action listener: set_extra_try_arguments 14:04:15 INFO - [mozharness: 2016-10-26 21:04:15.286179Z] Finished download-and-extract step (success) 14:04:15 INFO - [mozharness: 2016-10-26 21:04:15.286304Z] Running populate-webroot step. 14:04:15 INFO - Running pre-action listener: _resource_record_pre_action 14:04:15 INFO - Running main action method: populate_webroot 14:04:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:04:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:04:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:04:15 INFO - '--tppagecycles', 14:04:15 INFO - '7'], 14:04:15 INFO - 'tests': ['tsvgm']}}, 14:04:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:04:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:04:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:04:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:04:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:15 INFO - 'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:15 INFO - 'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['damp', 'tps']}, 14:04:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:15 INFO - 'tests': ['damp', 'tps']}, 14:04:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['dromaeo_dom']}, 14:04:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:04:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['basic_compositor_video']}, 14:04:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:04:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['a11yr', 14:04:15 INFO - 'ts_paint', 14:04:15 INFO - 'tpaint', 14:04:15 INFO - 'sessionrestore', 14:04:15 INFO - 'sessionrestore_no_auto_restore', 14:04:15 INFO - 'tabpaint']}, 14:04:15 INFO - 'other-e10s': {'tests': ['a11yr', 14:04:15 INFO - 'ts_paint', 14:04:15 INFO - 'tpaint', 14:04:15 INFO - 'sessionrestore', 14:04:15 INFO - 'sessionrestore_no_auto_restore', 14:04:15 INFO - 'tabpaint']}, 14:04:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:04:15 INFO - 'ts_paint', 14:04:15 INFO - 'tpaint', 14:04:15 INFO - 'sessionrestore', 14:04:15 INFO - 'sessionrestore_no_auto_restore', 14:04:15 INFO - 'tabpaint']}, 14:04:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:04:15 INFO - 'ts_paint', 14:04:15 INFO - 'tpaint', 14:04:15 INFO - 'sessionrestore', 14:04:15 INFO - 'sessionrestore_no_auto_restore', 14:04:15 INFO - 'tabpaint']}, 14:04:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['a11yr', 14:04:15 INFO - 'ts_paint', 14:04:15 INFO - 'tpaint', 14:04:15 INFO - 'sessionrestore', 14:04:15 INFO - 'sessionrestore_no_auto_restore', 14:04:15 INFO - 'tabpaint']}, 14:04:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['a11yr', 14:04:15 INFO - 'ts_paint', 14:04:15 INFO - 'tpaint', 14:04:15 INFO - 'sessionrestore', 14:04:15 INFO - 'sessionrestore_no_auto_restore', 14:04:15 INFO - 'tabpaint']}, 14:04:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['tsvgx', 14:04:15 INFO - 'tsvgr_opacity', 14:04:15 INFO - 'tart', 14:04:15 INFO - 'tscrollx', 14:04:15 INFO - 'cart']}, 14:04:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:04:15 INFO - 'tsvgr_opacity', 14:04:15 INFO - 'tart', 14:04:15 INFO - 'tscrollx', 14:04:15 INFO - 'cart']}, 14:04:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:15 INFO - 'talos_options': ['--disable-e10s'], 14:04:15 INFO - 'tests': ['tp5o']}, 14:04:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:15 INFO - 'tests': ['tp5o']}, 14:04:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:15 INFO - 'talos_options': ['--disable-e10s', 14:04:15 INFO - '--xperf_path', 14:04:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:15 INFO - 'tests': ['tp5n']}, 14:04:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:15 INFO - 'talos_options': ['--xperf_path', 14:04:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:15 INFO - 'tests': ['tp5n']}}, 14:04:15 INFO - 'talos.zip': {'path': '', 14:04:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:04:15 INFO - Running post-action listener: _resource_record_post_action 14:04:15 INFO - [mozharness: 2016-10-26 21:04:15.305228Z] Finished populate-webroot step (success) 14:04:15 INFO - [mozharness: 2016-10-26 21:04:15.305334Z] Running create-virtualenv step. 14:04:15 INFO - Running pre-action listener: _resource_record_pre_action 14:04:15 INFO - Running main action method: create_virtualenv 14:04:15 INFO - Creating virtualenv /builds/slave/test/build/venv 14:04: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:04:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:04:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:04:15 INFO - Using real prefix '/tools/python27' 14:04:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:04:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:04:19 INFO - Installing pip.................done. 14:04:19 INFO - Return code: 0 14:04:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:04: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:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x106000490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f76570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb429d6ff30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, '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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:04: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:04: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:04:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:04:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:19 INFO - 'HOME': '/Users/cltbld', 14:04:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:19 INFO - 'LOGNAME': 'cltbld', 14:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:19 INFO - 'MOZ_NO_REMOTE': '1', 14:04:19 INFO - 'NO_EM_RESTART': '1', 14:04:19 INFO - 'PAGER': '/bin/cat', 14:04:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:19 INFO - 'PWD': '/builds/slave/test', 14:04:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:19 INFO - 'SHELL': '/bin/bash', 14:04:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:04:19 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:04:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:19 INFO - 'USER': 'cltbld', 14:04:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:19 INFO - 'XPC_FLAGS': '0x0', 14:04:19 INFO - 'XPC_SERVICE_NAME': '0', 14:04:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04: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:04:19 INFO - Cleaning up... 14:04:19 INFO - Return code: 0 14:04:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:04: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:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x106000490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f76570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb429d6ff30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, '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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:04: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:04: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:04:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:04:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:19 INFO - 'HOME': '/Users/cltbld', 14:04:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:19 INFO - 'LOGNAME': 'cltbld', 14:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:19 INFO - 'MOZ_NO_REMOTE': '1', 14:04:19 INFO - 'NO_EM_RESTART': '1', 14:04:19 INFO - 'PAGER': '/bin/cat', 14:04:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:19 INFO - 'PWD': '/builds/slave/test', 14:04:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:19 INFO - 'SHELL': '/bin/bash', 14:04:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:04:19 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:04:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:19 INFO - 'USER': 'cltbld', 14:04:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:19 INFO - 'XPC_FLAGS': '0x0', 14:04:19 INFO - 'XPC_SERVICE_NAME': '0', 14:04:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:19 INFO - Downloading/unpacking psutil>=3.1.1 14:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:04:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:22 INFO - Installing collected packages: psutil 14:04:22 INFO - Running setup.py install for psutil 14:04:22 INFO - building 'psutil._psutil_osx' extension 14:04:22 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:04:22 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:04:22 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:04:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:04:23 INFO - building 'psutil._psutil_posix' extension 14:04:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:04:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:04:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:04:23 INFO - ^ 14:04:23 INFO - 1 warning generated. 14:04:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:04:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:23 INFO - Successfully installed psutil 14:04:23 INFO - Cleaning up... 14:04:23 INFO - Return code: 0 14:04:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106000490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f76570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb429d6ff30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, '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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:04:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:04:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:04:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:23 INFO - 'HOME': '/Users/cltbld', 14:04:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:23 INFO - 'LOGNAME': 'cltbld', 14:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:23 INFO - 'MOZ_NO_REMOTE': '1', 14:04:23 INFO - 'NO_EM_RESTART': '1', 14:04:23 INFO - 'PAGER': '/bin/cat', 14:04:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:23 INFO - 'PWD': '/builds/slave/test', 14:04:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:23 INFO - 'SHELL': '/bin/bash', 14:04:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:04:23 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:04:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:23 INFO - 'USER': 'cltbld', 14:04:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:23 INFO - 'XPC_FLAGS': '0x0', 14:04:23 INFO - 'XPC_SERVICE_NAME': '0', 14:04:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:04:23 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:04:23 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:04:23 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:04:23 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:04:23 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:04:23 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:04:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:04:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:04:26 INFO - Installing collected packages: mozsystemmonitor 14:04:26 INFO - Running setup.py install for mozsystemmonitor 14:04:26 INFO - Successfully installed mozsystemmonitor 14:04:26 INFO - Cleaning up... 14:04:26 INFO - Return code: 0 14:04:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:26 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 0x106000490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f76570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb429d6ff30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, '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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:04:26 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:04:26 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:04:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:04:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:26 INFO - 'HOME': '/Users/cltbld', 14:04:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:26 INFO - 'LOGNAME': 'cltbld', 14:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:26 INFO - 'MOZ_NO_REMOTE': '1', 14:04:26 INFO - 'NO_EM_RESTART': '1', 14:04:26 INFO - 'PAGER': '/bin/cat', 14:04:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:26 INFO - 'PWD': '/builds/slave/test', 14:04:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:26 INFO - 'SHELL': '/bin/bash', 14:04:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:04:26 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:04:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:26 INFO - 'USER': 'cltbld', 14:04:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:26 INFO - 'XPC_FLAGS': '0x0', 14:04:26 INFO - 'XPC_SERVICE_NAME': '0', 14:04:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:26 INFO - Downloading/unpacking jsonschema==2.5.1 14:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:04:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:29 INFO - Downloading functools32-3.2.3-2.tar.gz 14:04:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:04:29 INFO - warning: no files found matching '*.txt' 14:04:29 INFO - no previously-included directories found matching 'build' 14:04:29 INFO - no previously-included directories found matching 'dist' 14:04:29 INFO - no previously-included directories found matching '.git*' 14:04:29 INFO - Installing collected packages: jsonschema, functools32 14:04:29 INFO - Running setup.py install for functools32 14:04:29 INFO - warning: no files found matching '*.txt' 14:04:29 INFO - no previously-included directories found matching 'build' 14:04:29 INFO - no previously-included directories found matching 'dist' 14:04:29 INFO - no previously-included directories found matching '.git*' 14:04:30 INFO - Successfully installed jsonschema functools32 14:04:30 INFO - Cleaning up... 14:04:30 INFO - Return code: 0 14:04:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106000490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f76570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb429d6ff30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, '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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:04:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:04:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:30 INFO - 'HOME': '/Users/cltbld', 14:04:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:30 INFO - 'LOGNAME': 'cltbld', 14:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:30 INFO - 'MOZ_NO_REMOTE': '1', 14:04:30 INFO - 'NO_EM_RESTART': '1', 14:04:30 INFO - 'PAGER': '/bin/cat', 14:04:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:30 INFO - 'PWD': '/builds/slave/test', 14:04:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:30 INFO - 'SHELL': '/bin/bash', 14:04:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:04:30 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:04:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:30 INFO - 'USER': 'cltbld', 14:04:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:30 INFO - 'XPC_FLAGS': '0x0', 14:04:30 INFO - 'XPC_SERVICE_NAME': '0', 14:04:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:04:30 INFO - Cleaning up... 14:04:30 INFO - Return code: 0 14:04:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106000490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f76570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb429d6ff30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, '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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:04:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:04:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:30 INFO - 'HOME': '/Users/cltbld', 14:04:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:30 INFO - 'LOGNAME': 'cltbld', 14:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:30 INFO - 'MOZ_NO_REMOTE': '1', 14:04:30 INFO - 'NO_EM_RESTART': '1', 14:04:30 INFO - 'PAGER': '/bin/cat', 14:04:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:30 INFO - 'PWD': '/builds/slave/test', 14:04:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:30 INFO - 'SHELL': '/bin/bash', 14:04:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:04:30 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:04:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:30 INFO - 'USER': 'cltbld', 14:04:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:30 INFO - 'XPC_FLAGS': '0x0', 14:04:30 INFO - 'XPC_SERVICE_NAME': '0', 14:04:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:04: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:04: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:04: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:04: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:04: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:04: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:04:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:04:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:04:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:04:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:34 INFO - Downloading docopt-0.6.1.tar.gz 14:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:04:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:04:34 INFO - Running setup.py install for blobuploader 14:04:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:04:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:04:34 INFO - Running setup.py install for requests 14:04:35 INFO - Running setup.py install for docopt 14:04:35 INFO - Successfully installed blobuploader requests docopt 14:04:35 INFO - Cleaning up... 14:04:35 INFO - Return code: 0 14:04:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106000490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f76570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb429d6ff30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, '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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:04:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:04:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:35 INFO - 'HOME': '/Users/cltbld', 14:04:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:35 INFO - 'LOGNAME': 'cltbld', 14:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:35 INFO - 'MOZ_NO_REMOTE': '1', 14:04:35 INFO - 'NO_EM_RESTART': '1', 14:04:35 INFO - 'PAGER': '/bin/cat', 14:04:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:35 INFO - 'PWD': '/builds/slave/test', 14:04:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:35 INFO - 'SHELL': '/bin/bash', 14:04:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:04:35 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:04:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:35 INFO - 'USER': 'cltbld', 14:04:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:35 INFO - 'XPC_FLAGS': '0x0', 14:04:35 INFO - 'XPC_SERVICE_NAME': '0', 14:04:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-brpBDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-GJzXCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-xL7yg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-uFftoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-TulcgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-6tqr5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-53nuiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-FbbuyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-RPIWgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-dTAs_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-FybE5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-eaarJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:36 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-lRjWyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:37 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-LEY_Yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:37 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-oz1MFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:37 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-jnWqux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:37 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-9r8NIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:04:37 INFO - Running setup.py install for manifestparser 14:04:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:04:37 INFO - Running setup.py install for mozcrash 14:04:37 INFO - Running setup.py install for mozdebug 14:04:37 INFO - Running setup.py install for mozdevice 14:04:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:04:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:04:37 INFO - Running setup.py install for mozfile 14:04:38 INFO - Running setup.py install for mozhttpd 14:04:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:04:38 INFO - Running setup.py install for mozinfo 14:04:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:04:38 INFO - Running setup.py install for mozInstall 14:04:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:04:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:04:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:04:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:04:38 INFO - Running setup.py install for mozleak 14:04:38 INFO - Running setup.py install for mozlog 14:04:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:04:38 INFO - Running setup.py install for moznetwork 14:04:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:04:39 INFO - Running setup.py install for mozprocess 14:04:39 INFO - Running setup.py install for mozprofile 14:04:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:04:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:04:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:04:39 INFO - Running setup.py install for mozrunner 14:04:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:04:39 INFO - Running setup.py install for mozscreenshot 14:04:39 INFO - Running setup.py install for moztest 14:04:39 INFO - Running setup.py install for mozversion 14:04:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:04:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:04:39 INFO - Cleaning up... 14:04:39 INFO - Return code: 0 14:04:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:39 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 0x106000490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f76570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb429d6ff30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, '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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:04:39 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:04:39 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:04:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:04:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:39 INFO - 'HOME': '/Users/cltbld', 14:04:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:39 INFO - 'LOGNAME': 'cltbld', 14:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:39 INFO - 'MOZ_NO_REMOTE': '1', 14:04:39 INFO - 'NO_EM_RESTART': '1', 14:04:39 INFO - 'PAGER': '/bin/cat', 14:04:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:39 INFO - 'PWD': '/builds/slave/test', 14:04:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:39 INFO - 'SHELL': '/bin/bash', 14:04:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:04:39 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:04:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:39 INFO - 'USER': 'cltbld', 14:04:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:39 INFO - 'XPC_FLAGS': '0x0', 14:04:39 INFO - 'XPC_SERVICE_NAME': '0', 14:04:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-c60Yzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-VQmevu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-CEpGzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:40 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:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-E9drRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:40 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:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bTsEpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:40 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:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-oa9Lc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:40 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:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-6QydsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:40 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:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-WAeS7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04: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:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-wDPgaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-TZo5Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-0Rp0R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-u7YAPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-lc1MEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:41 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:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-PmgvVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:41 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:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-NsJhJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:41 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:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-eHlVzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:41 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:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-jRhxyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04: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:04: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:04: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:04: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:04: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:04: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:04:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:04: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:04: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:04: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:04: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:04: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:04: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:04:44 INFO - Downloading blessings-1.6.tar.gz 14:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:04:44 INFO - Installing collected packages: blessings 14:04:44 INFO - Running setup.py install for blessings 14:04:44 INFO - Successfully installed blessings 14:04:44 INFO - Cleaning up... 14:04:45 INFO - Return code: 0 14:04:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:04:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:04:45 INFO - Reading from file tmpfile_stdout 14:04:45 INFO - Current package versions: 14:04:45 INFO - blessings == 1.6 14:04:45 INFO - blobuploader == 1.2.4 14:04:45 INFO - docopt == 0.6.1 14:04:45 INFO - functools32 == 3.2.3-2 14:04:45 INFO - jsonschema == 2.5.1 14:04:45 INFO - manifestparser == 1.1 14:04:45 INFO - mozInstall == 1.12 14:04:45 INFO - mozcrash == 0.17 14:04:45 INFO - mozdebug == 0.1 14:04:45 INFO - mozdevice == 0.48 14:04:45 INFO - mozfile == 1.2 14:04:45 INFO - mozhttpd == 0.7 14:04:45 INFO - mozinfo == 0.9 14:04:45 INFO - mozleak == 0.1 14:04:45 INFO - mozlog == 3.4 14:04:45 INFO - moznetwork == 0.27 14:04:45 INFO - mozprocess == 0.23 14:04:45 INFO - mozprofile == 0.28 14:04:45 INFO - mozrunner == 6.12 14:04:45 INFO - mozscreenshot == 0.1 14:04:45 INFO - mozsystemmonitor == 0.3 14:04:45 INFO - moztest == 0.7 14:04:45 INFO - mozversion == 1.4 14:04:45 INFO - psutil == 3.1.1 14:04:45 INFO - requests == 1.2.3 14:04:45 INFO - wsgiref == 0.1.2 14:04:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106000490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f76570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb429d6ff30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, '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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:04:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:04:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:04:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:45 INFO - 'HOME': '/Users/cltbld', 14:04:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:45 INFO - 'LOGNAME': 'cltbld', 14:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:45 INFO - 'MOZ_NO_REMOTE': '1', 14:04:45 INFO - 'NO_EM_RESTART': '1', 14:04:45 INFO - 'PAGER': '/bin/cat', 14:04:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:45 INFO - 'PWD': '/builds/slave/test', 14:04:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:45 INFO - 'SHELL': '/bin/bash', 14:04:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:04:45 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:04:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:45 INFO - 'USER': 'cltbld', 14:04:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:45 INFO - 'XPC_FLAGS': '0x0', 14:04:45 INFO - 'XPC_SERVICE_NAME': '0', 14:04:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:45 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:04:45 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:04:45 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:04:45 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:04:45 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:04:45 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:04:45 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:04:45 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:04:45 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:04:45 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:04:45 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:04:45 INFO - Cleaning up... 14:04:45 INFO - Return code: 0 14:04:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:45 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 0x106000490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f76570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb429d6ff30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, '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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:04:45 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:04:45 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:04:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:04:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:45 INFO - 'HOME': '/Users/cltbld', 14:04:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:45 INFO - 'LOGNAME': 'cltbld', 14:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:45 INFO - 'MOZ_NO_REMOTE': '1', 14:04:45 INFO - 'NO_EM_RESTART': '1', 14:04:45 INFO - 'PAGER': '/bin/cat', 14:04:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:45 INFO - 'PWD': '/builds/slave/test', 14:04:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:45 INFO - 'SHELL': '/bin/bash', 14:04:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:04:45 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:04:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:45 INFO - 'USER': 'cltbld', 14:04:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:45 INFO - 'XPC_FLAGS': '0x0', 14:04:45 INFO - 'XPC_SERVICE_NAME': '0', 14:04:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:04:45 INFO - Cleaning up... 14:04:45 INFO - Return code: 0 14:04:45 INFO - Running post-action listener: _resource_record_post_action 14:04:45 INFO - Running post-action listener: _start_resource_monitoring 14:04:45 INFO - Starting resource monitoring. 14:04:45 INFO - [mozharness: 2016-10-26 21:04:45.895176Z] Finished create-virtualenv step (success) 14:04:45 INFO - [mozharness: 2016-10-26 21:04:45.896167Z] Running install step. 14:04:45 INFO - Running pre-action listener: _resource_record_pre_action 14:04:45 INFO - Running main action method: install 14:04:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:04:46 INFO - Reading from file tmpfile_stdout 14:04:46 INFO - Detecting whether we're running mozinstall >=1.0... 14:04:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:04:46 INFO - Reading from file tmpfile_stdout 14:04:46 INFO - Output received: 14:04:46 INFO - Usage: mozinstall [options] installer 14:04:46 INFO - Options: 14:04:46 INFO - -h, --help show this help message and exit 14:04:46 INFO - -d DEST, --destination=DEST 14:04:46 INFO - Directory to install application into. [default: 14:04:46 INFO - "/builds/slave/test"] 14:04:46 INFO - --app=APP Application being installed. [default: firefox] 14:04:46 INFO - mkdir: /builds/slave/test/build/application 14:04:46 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:04:46 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:05:18 INFO - Reading from file tmpfile_stdout 14:05:18 INFO - Output received: 14:05:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:05:18 INFO - Running post-action listener: _resource_record_post_action 14:05:18 INFO - [mozharness: 2016-10-26 21:05:18.532492Z] Finished install step (success) 14:05:18 INFO - [mozharness: 2016-10-26 21:05:18.532628Z] Running run-tests step. 14:05:18 INFO - Running pre-action listener: _resource_record_pre_action 14:05:18 INFO - Running main action method: run_tests 14:05:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:05:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:05:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:05:18 INFO - 2016-10-26 14:05:18.547 screenresolution[1636:7383] starting screenresolution argv=screenresolution get 14:05:18 INFO - 2016-10-26 14:05:18.549 screenresolution[1636:7383] Display 0: 1600x1200x32@60 14:05:18 INFO - 2016-10-26 14:05:18.555 screenresolution[1637:7386] starting screenresolution argv=screenresolution list 14:05:18 INFO - Available Modes on Display 0 14:05:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:05:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:05:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:05:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:05:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:05:18 INFO - Intel Iris: 14:05:18 INFO - Chipset Model: Intel Iris 14:05:18 INFO - Type: GPU 14:05:18 INFO - Bus: Built-In 14:05:18 INFO - VRAM (Dynamic, Max): 1536 MB 14:05:18 INFO - Vendor: Intel (0x8086) 14:05:18 INFO - Device ID: 0x0a2e 14:05:18 INFO - Revision ID: 0x0009 14:05:18 INFO - Displays: 14:05:18 INFO - Display: 14:05:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:05:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:05:18 INFO - Display Serial Number: 1600x1200 60 14:05:18 INFO - Main Display: Yes 14:05:18 INFO - Mirror: Off 14:05:18 INFO - Online: Yes 14:05:18 INFO - Rotation: Supported 14:05:18 INFO - Return code: 0 14:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:05:18 INFO - Python 2.7.3 14:05:18 INFO - Return code: 0 14:05:18 INFO - grabbing minidump binary from tooltool 14:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:18 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 0x105e14d30>, '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 0x105c7adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e0cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:05:18 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:05:18 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:05:18 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:05:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:05:18 INFO - Return code: 0 14:05:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:05:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:05:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:05:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:05:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:05:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lYIYGjKtx9/Render', 14:05:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:18 INFO - 'HOME': '/Users/cltbld', 14:05:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:18 INFO - 'LOGNAME': 'cltbld', 14:05:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:05:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:18 INFO - 'MOZ_NO_REMOTE': '1', 14:05:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:05:18 INFO - 'NO_EM_RESTART': '1', 14:05:18 INFO - 'PAGER': '/bin/cat', 14:05:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:18 INFO - 'PWD': '/builds/slave/test', 14:05:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:05:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:18 INFO - 'SHELL': '/bin/bash', 14:05:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nFO9CYDjP2/Listeners', 14:05:18 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:05:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:18 INFO - 'USER': 'cltbld', 14:05:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:18 INFO - 'XPC_FLAGS': '0x0', 14:05:18 INFO - 'XPC_SERVICE_NAME': '0', 14:05:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:05:19 INFO - mozversion application_buildid: 20161026004014 14:05:19 INFO - mozversion application_changeset: a16ab27e533088e1711a82ff380d3ebd262ca837 14:05:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:05:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:05:19 INFO - mozversion application_name: Firefox 14:05:19 INFO - mozversion application_remotingname: firefox-dev 14:05:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:05:19 INFO - mozversion application_vendor: Mozilla 14:05:19 INFO - mozversion application_version: 51.0a2 14:05:19 INFO - mozversion platform_buildid: 20161026004014 14:05:19 INFO - mozversion platform_changeset: a16ab27e533088e1711a82ff380d3ebd262ca837 14:05:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:05:19 INFO - mozversion platform_version: 51.0a2 14:05:19 INFO - using testdate: 1477515919 14:05:19 INFO - actual date: 1477515919 14:05:19 INFO - starting webserver on 'localhost:49267' 14:05:19 INFO - SUITE-START | Running 2 tests 14:05:19 INFO - TEST-START | dromaeo_css 14:05:19 INFO - operating with platform_type : mac_ 14:05:19 INFO - Initialising browser for dromaeo_css test... 14:05:19 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpM6q7u3/profile http://localhost:49267/getInfo.html) 14:05:21 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 14:05:21 INFO - PROCESS | 1647 | colorDepth:24 14:05:21 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 14:05:21 INFO - PROCESS | 1647 | __metrics 14:05:21 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:05:21 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:22 INFO - TEST-INFO | 1647: exit 0 14:05:22 INFO - Browser initialized. 14:05:22 INFO - Running cycle 1/1 for dromaeo_css test... 14:05:22 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpM6q7u3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:34 INFO - PROCESS | 1650 | RSS: Main: 219320320 14:05:34 INFO - PROCESS | 1650 | 14:06:25 INFO - PROCESS | 1650 | 1477515985648 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:08:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 14:08:39 INFO - PROCESS | 1650 | RSS: Main: 370966528 14:08:39 INFO - PROCESS | 1650 | 14:11:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 14:11:42 INFO - PROCESS | 1650 | RSS: Main: 352018432 14:11:42 INFO - PROCESS | 1650 | 14:14:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 14:14:45 INFO - PROCESS | 1650 | RSS: Main: 318652416 14:14:45 INFO - PROCESS | 1650 | 14:17:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 14:17:48 INFO - PROCESS | 1650 | RSS: Main: 332509184 14:17:48 INFO - PROCESS | 1650 | 14:20:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 14:20:52 INFO - PROCESS | 1650 | RSS: Main: 311693312 14:20:52 INFO - PROCESS | 1650 | 14:23:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 14:23:55 INFO - PROCESS | 1650 | RSS: Main: 499232768 14:23:55 INFO - PROCESS | 1650 | 14:23:55 INFO - PROCESS | 1650 | __start_tp_report 14:23:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 14:23:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 14:23:55 INFO - PROCESS | 1650 | |i|pagename|runs| 14:23:55 INFO - PROCESS | 1650 | |0;dojo.html;3367.2760356523345;3380.2901390707943;3414.2317978454853;3427;3458;5726.083826587746;5729.0833466645345;5784.537237021039;5837.649741015542;5855.033919403299;5721.141828725693;5787.768489260425;5789.189513468107;5802.158686990384;5810.128480727893;5202.8699282518055;5241.606879484035;5268.789248430077;5270.789168433258;5291.973540132313;5168;5178.896422071556;5197.896042079156;5334.306540149794;5355.303810504629;5205.193195054772;5267.55225805807;5294.311739473882;5294.92057619136;5309.62832601718;5249.396319423239;5269.2623032775255;5279.392869819982;5279.6832190068335;5292.44429334922;5222.529972302511;5242.947570524284;5266.1574148136115;5267.815626453094;5286.286351342558;4615.792289346988;4687;5639.2668953036255;5652.5195358394585;5816.331121920949;6158.384161583851;6184.412480814315;6205.565610407273;6212.65830379329;6229.221347331583;5500.669959802424;6238.054126348038;6257.87484250317;6292.905606415908;6321.494280457552;5671.971640141773;5739.799107031234;5743.93737158627;5859.589828711992;5904.645721256738;6177.598456100339;6194.81415557534;6224.657643829542;6273.843153921189;6286.277078136073;6168.537359698041;6172.475339596095;6174.073888916609;6185.8144255672405;6192.380761923861;6125.632272693312;6181.227346581677;6235.469985051231;6241.251049874044;6251.218597675291;6137.4995631051315;6197.566170368031;6209.844753881189;6210.472109870621;6265.530085243534;6221.160143380585;6236.158118653923;6271.278802937721;6292.276388215322;6294.213223347082;4847.684900481458;4913.582345500672;4947.134251505972;4951.777170027357;4971.577415919615;4372.672049596293;4375.978120109379;4435.290353543418;4443.933340999887;4449.733016018984;5919.467247947619;5925.792597259076;5927.4665280125;5929.14027466015;5952.940470595326;6260.718267677966;6265.342139075423;6269.059641053878;6275.811725648238;6288.088227207029;5672.631278966854;5688.601797874109;5730.656160630376;5787.479126878601;5864.325602555676;5390.838274851761;5404.675719456845;5432.864178395572;5453.072977593819;5479.698616576126;5588.21764952907;6229.96885015572;6395.744170233139;6424.357564243538;6427.260865000491;6090.116933044772;6191.659458729633;6270.561060725706;6279.843003924939;6290.748370065146;5758.452946970031;6232.937670623236;6289.905651415141;6350.174477317919;6373.203349581302;5139.8458046258675;6141.301904043499;6159.168512250789;6178.66017369049;6189.597676151036;6031.185789918305;6247.219097612799;6275.3724627536885;6314.778982735582;6317.210348706411;5965;6024.096385542204;6067.150598916067;6105.908411373922;6162.784302549569;6136.764169924236;6153.938460615336;6160.075988601567;6162.722677479614;6175.166352542349;5991.921454138297;6022.36765139654;6044.909326360196;6049.939500604937;6054.8183554493435;6002.609830361187;6046.637201767908;6084.330723620486;6154.353792851865;6181.81454556364;5925.674087925033;5936.554758393224;5991.281046274301;6054.091886217103;6067.24159480065 14:23:55 INFO - PROCESS | 1650 | |1;ext.html;477.5153219482226;521.0542864700568;528.5322489596708;536.3376230355512;537.2639483907047;30615.540766888513;41022.794886025564;42213;42367.57632423679;42416.575834241645;43632.12735745283;43919.3412098818;43999.78000109995;44033.7798311008;44132;9739.756506087351;9920.950395248014;9938.503074846265;9941.502924853728;9956.701298961007;8631.784205394853;8834.690785822497;8839.911600883974;8956.955215223947;9745.90254097457;8993.775155621097;11939.58211462599;12195.878041219607;12206.694832629211;12462.003039756797;12098.697532561713;12174.513019479211;12180.878191218064;12183.086268529807;12189.695257618541;11847.348395838226;11935.462904169333;11946;11952.462139203757;11956.701082473008;40014.799556013364;40352.79823600863;40380;40517.189656207;40565.79717101395;3426.6059403168706;3431.656834316548;3469.3755124077657;3578.58846232684;3683.4290684943876;30314.54528182079;31134.37731245385;31449.842750786327;31586.842065789755;32160.356792864244;3085.1053194573547;3183.4110689522513;3204.743620510377;3257.218267615755;3277.115178901683;542119;545296;546113.999999996;547206;547245;63425;64095.359046409874;64162.67918660377;64274.035889461695;64312.678436607515;34759.82620086883;35101.122471938404;35478.29043419117;36656;36743;16980.74528882068;17108.401205957733;17123.657526849394;17134.485965421056;17137.314507419815;13074.738505229841;13075;13107.14803537767;13116.672083197805;13120.60638180856;16567.917160414363;16875.071871046966;19333.61332773337;19352.4194274172;19361.709574356395;6555.410013098844;7727.729529466442;7779.805504862424;7781.727639532589;7852.411069169835;846.4075147396846;927.3462209142539;975.1857199238574;1008.7138897905083;1011.5751384418414;28616.570751438747;29512.852435737685;30391.24021899426;30990.22524436862;31013.68986310108;1075.6772968109535;1076.424113099488;1078.0674716370283;1101.4878081692052;1124.0333313350511;15201.771973420407;15610.517000885126;15725.528234152993;15822.446214382442;16078.437254696264;739109;741225;741789;743216;747637;49478.257826132634;50623;56397.43602564004;57862.421375786544;58354;1340.6380277325068;1351.3783659516537;1384.3770303363326;1385.861413858606;1396.0018586710348;29994.434063531327;31247.843760781052;31536.369272614877;31682.207944801565;32315.838420807744;50818.23772643339;51409.74295128501;51416.48583514117;51478.22782658188;51562.22656660078;687526;697401;698765;934768;934839;41221.76334709964;41541.584584153774;41681.58318416777;42027;42212.78893605512;43515.347269791615;45155.54844451514;45436.54563454323;45515.317270241634;45876;37534.249315014094;38060.2387952245;38600;38729.4190587147;39784.80107599444;37327.626723732414;37757.622423775414;37803;38086.23827523379;39379.80310098431;30248;37656.623433765315;37704.05739856416;39559;39583;29101.7089829099;33195.33609327752;34441.65558344385;35367.29265414626;35522.93431197068;26071.608925866505;26106.60840087362;26112.216633501026;26219;26448.338791530365 14:23:55 INFO - PROCESS | 1650 | |2;jquery.html;344.79140120227277;368.08714388316974;377.15329086201484;383.2756090988032;406.46955722781775;15095.698086038272;15115.470958516455;16828.66342673146;20838.47903802402;21514.677279840816;19848.106835192415;20313.39059828204;20608.8969555152;20745.377638670827;20772.896135519302;5349.652272602279;5596.720163991784;5598.776048958037;5639.295088113986;5662.17898404731;5912.320083190445;6078.848028799272;6099.847503812396;6105.572609917308;6108.541859360544;5800.158976948361;6042.788502402417;6052.455279024887;6059.3637668044885;6065.939340606582;6075.574709770318;6087.543434242428;6110.755569777203;6117.541184411187;6122.8775424491705;5192.636515443921;5403.8108666196495;5459.781608735646;5563.666180029211;5895.941040589582;12958.22250664963;13079;13145.342732863413;13158.473661053546;13204.273764942924;2055.6813693877325;2212.9446763830874;2242.3273018094505;2243.2372993182234;2427.4659574893494;9642.325037247396;9699.369540979813;10350.327228730108;10947.890521094767;15798.289076991563;1552.6972240413124;1659.6846599146124;1791.570023194437;1834.7431359609666;1838.4025191812714;111660;117793;117804;118706.81293187045;120725;10506.527206275736;11576.768464630828;11718;11756.647300580997;11997;14953.476628317956;14958.027728197632;14959.401623935139;14972.850271497364;14977.625559360886;7942.682292708342;8069.394795390369;8129.552874591836;8193.180681931759;8202.138775428613;7717.57553334572;7742.032245969254;7752.7286544971785;7806.960965195138;7851.900733897259;3849.3840985442193;4468.017036252019;4539.387182730356;4560.065186636732;4652.976735116303;1857.7399164117035;1914.7032210007471;1917.3481016454473;1926.2969016308946;1944.6596845551971;813.7477382011596;845.5476320168681;884.6638277454526;922.5756152170077;943.1558754914313;19908.60182796336;20364.796352036585;20448.465151304943;20532.692009619568;20741.170353186004;897.3583887520324;934.9158575728217;946.8390373636498;954.398728800851;967.4340510801119;10200.591976321013;10440.947795261127;10469.790604188025;10896.78206435867;10942.398168100832;596165;607770;607865;620994;626417;131890;133097;134459;136211.31894340465;137411;958.5399008475971;974.4835237324229;996.4668902137466;1017.4404077757204;1019.4036488654073;17419;18219.90890045541;18553.35063272779;18602.534936626693;18676.533086672942;50008.249876252616;50225.49774502208;50430.747846260536;52938.735306324765;54436;71872;76337.85493217495;79279.20720792719;81003.59498202472;81509;7971.3224375926375;7996.56018918965;8012.599370031592;8269.71819367999;8269.875951860606;10041.523217524802;10826.512806923865;12196.146269761031;12786.744265114832;13115.27865967381;4372.737635741865;5144.125498665311;9865.852012219966;10843.481912532094;11232.494537745984;10642.680719578426;10846.783064338511;10995.230333876552;11454.255473394203;11492.54029838797;11415.200935934738;11450.198486105892;11519.942400287944;11695.590654327398;11903.345316007702;8059.274665280153;8193.50838949665;8248.422610417214;8525.786855328666;8691.608877600649;8368.24685778283;11146.55413783472;11210.55157793679;11615.245009074382;11748.118891083373 14:23:55 INFO - PROCESS | 1650 | |3;mootools.html;1316.2694704439032;1378.689794796171;1459.5767227504025;1622.4889159914626;1858.0709645177403;7921.366290696737;8501.107383724713;8504.574771261443;8505.659773609055;8506.489610623352;8281.627326770295;8689.391742578022;8911.376203665746;8912;9109.40788848726;2036.786137455568;2390.3904504351367;2417.347316224618;2417.601095819188;2419.177479656916;2351.235848349285;2389.1637926725593;2400.663907053014;2402.1832576923844;2406.8074554035725;2357.210334537932;2384.821138414617;2389.796867266276;2399.400149962509;2401.315625046862;2340.0639744102323;2357.35172827473;2370.3363058343693;2373.3354660695118;2379.262428647125;2342.3675607585856;2375.1568193291305;2375.786179243876;2377;2379.964300535476;8885.4668719877;9115.361924665276;9119.772005699844;9126.498042607654;9149.862752058725;5197.220416937452;5244.580433565306;5402.486763757437;5404.243405923174;5425.240466334716;3546.840392182358;3641.6176301488226;3719.2933342664805;3732;3746.0260332313524;1086.6957251969461;1090.0407641275706;1091.165258577189;1100.350793032115;1113.9665810025713;10311.381317120997;12139.028877689852;12247.571335003233;12259.570915017932;12290.385480725929;4003.679705623543;4489.012417268195;4624.1445332613575;4681.133990211822;4723.504032076651;9420.858687119699;9424.811503769886;9434.764130896783;9440.24478041755;9464.337496375325;5299.152135658276;5300.337457817773;5302.787888484495;5304.840854774363;5326.9467305327225;4129.607687269705;4414.470263568328;4443.400140980926;4558.908821823545;4945.604351651859;3159.210197450637;3317.4360358739073;3841.2317536492255;3917.9822391468415;3921.9998900280248;1061.3472714280815;1107.8091052119005;1142.308903113621;1143.5482984221187;1164.3886959346412;777.9105402878628;786.3591173193829;926.129438327983;934.5747684803398;951.6003278622857;5871.32479764824;5880.8235752927485;5881.852953676193;6024.759009639653;6164.260288765377;425.5149129991812;959.8752162218867;978.7699890525721;987.0573602209872;1038.4859494550094;3884.786336751449;3958.188571342868;3972;4017.1563971566297;4108.77401742901;10756.247062705692;11012.284201526874;11092.445377731081;11110.277831940897;11148.609798657008;10997.285176463663;11012.119030477543;11013.2841365311;11084.501197446134;11085.002349788558;6717.932820671828;8332.66669333232;8342.040665323444;8490.745277641681;8491.15088491146;5944.256967879015;5993.820185394445;6023.066424704178;6110.938890611214;6200.596961197508;9272.629094836131;10044.844842843166;10307.433091180057;10368.481575921325;10387.94806025965;9467.431954082776;10081.949590252296;10451.738706532093;10545.9472702636;10574.735631608964;7207.315305046012;7413.8146546336775;7421.740239091606;7422.369098626677;7424.220456852169;7513.737019204302;8288.419810613199;8293.502389856629;8447.408681392244;8510.021347545111;7739.419543534144;7746;7795.22047795216;7801.102873169658;7801.1808760079375;7530.6611202497115;7553.206913274247;7560.986500364488;7699.076110866732;7769;6999.195092564217;7034.472414568825;7073;7121.216666166614;7141.9642901785155;4957.876053098701;4968.403791545038;5076.873078173076;5111.488851114858;5237.292965449616;5001.749912504433;5026.748662566784;5107.157319042316;5154.994776018641;5310.070737620978 14:23:55 INFO - PROCESS | 1650 | |4;prototype.html;286.93543952610656;296.3110767465643;301.7359810166105;306.940146671399;308.5187108111348;4469.396631454757;4701.85894423167;4848.8787780305465;5054.671446355985;5322.2282768998475;4826.069572171134;4925.82759603414;5014.874628134289;5016.398032236128;5218.425973142951;3630.5824830144475;4038.474998250238;4044.0992733415324;4049.6760259179196;4087.9591204088024;3177.7298929590897;4022.255882661717;4024.235395274903;4036.3340048891896;4085.754854708727;3363.6131844837914;3968.7973174887925;4020.115574573589;4059.8632382932824;4075.4498142750795;4023.8591649292134;4031.9596804031876;4055.4727885374714;4056.6146216109423;4068.247374235776;2664.0276299150864;3152.858121384543;3476.5480487536456;3495.842687079062;3521.2605352875926;4365.738055716667;4689.437267527885;4734.431868175807;4795.784189711437;5155.32980712505;4387.811854441455;4563.612092972101;4587.912499812577;4598.218302888517;4636;4810.85567432974;5385.246065550826;5386.4074951755665;5481.671099734029;5489.58828087891;3205.8076515408916;3386.6444023377435;3672.467492213614;3850.3261929162563;3870.59358767331;5160.92258616121;5515.814099968486;5526.977509160858;5724.484796368305;5967.850803729942;3278.4098862205033;3282.343531293751;3919.568847426781;3932.9606703932595;3941;3922.882313530599;3962.968329228143;3967.1867267210155;3987.541432735273;4003.3794761811964;4063.4717486726536;4427.933580996288;4472.971216620195;4558.384618076583;4654.767261636905;4668.533146685372;5437.483439073281;5481.342238931354;5495.53287970519;5588.3573389060775;1122.8989390954853;1159.0727418065683;1183.9348835814112;1285.363744946239;1348.9730205395838;843.0347252395973;874.7463235661587;883.8188171424971;893.7586851550045;922.4972390047441;5199.766010529535;5249.317588713443;5264.525932738839;5309.867178364783;5317.255584218213;4754.667173297905;4934.766308422894;4990.750462476862;4994.825181118644;5496.735750777344;4386.692931494765;4467.15124126415;4728.810847566127;4934.9013019739405;5242.475752424803;2601.6747906511687;2681.396685745731;2763.2677340504783;2860.270630989126;2991.3718119195214;4916.385451818523;4959.454460009396;5792.623479473821;5815.3021637402935;5892.469677729025;5423.538999185034;5663.461971112738;5704.515116215168;5805.796797112081;5833.854153646193;5114.616403769732;5868.354481007086;5894.67579283135;5912.408759124053;5922;4383.824647014211;5056.772445240046;5412.945870541244;5602.747876345656;5638.689872057076;5011.271111466538;5472.2338872557075;5656.238601330069;5738.799142030009;5758.337791154071;4589.462530052469;4847.175980083323;5081.466446023114;5981.850453738692;6066.878662426639;3300.62042865064;3619.3123306571665;3631.9636803632684;3811.9237615248094;3853.942190867195;4743.312219728051;5110.361204849394;5459.836204913859;5476.890462190813;5853.239078919713;5696.344920334214;5705.087186050212;5713.714314284352;5718.456746609066;5728.627639203439;4618.4457865055065;4621.976890115528;4875.975620121877;4881.438634556929;5558.138488534284;4581.083783243432;5136.743162841918;5137.51193636604;5433.646812957145;5457.481539253765;5049.314000779525;5347.812826551052;5416.7270691388285;5542.168674698827;5583.1904373864745;4652.022890271689;4665.976670116764;5484.698341591251;5539.861503462284;5563.360213575491 14:23:55 INFO - PROCESS | 1650 | |5;yui.html;630.8864404407204;710.7547895975887;775.8952541406908;787.8030492376906;815.6411179081206;15241.542753717378;16421.178941052945;16430.424935127274;16433.260503277383;16468.588285292873;14128.788068178985;14166.858331416683;14182.71634567308;14215.431382744679;14271.78592321116;645.3481983196981;668.9899651505232;674.6694119881272;756.8004712530645;771.6643260181811;810.3760104719393;819.397742659145;836.9497830130211;840.7687885831415;841.9242268195861;883.4964070479829;887.4941283468426;887.8046829697456;887.8224355129;888.6800751729372;688.6178171115029;708.1042481261157;882.4749274181852;883.4610887358738;883.8939327280735;635.8982562789978;648.8442773734317;654.035297935546;657.1916542652516;657.697459168783;15154.469593564283;15194.772078418833;15231.390744370212;15248.31382587775;15252.694946101126;13800;13810.516631917935;13946.721065578631;14040.92979535106;14100.92949535256;12540.623781286577;12692;12837.29394883281;12857.549985750455;13353.399097040656;4462.085272519158;4513.50351461339;4572.382728331666;4582.991741816795;4728.267118596623;110402.89597104087;110795.89204108017;115647.84352156454;117144.41427792891;117274;10432.2697411182;10900.746414162315;11193.097292472446;11381;11505.137114716263;20778.792212077988;21716.891415543138;22470;22726;22745.203917862797;8052.758417247492;8076.757697269091;8109.959450202829;8126.309263712533;8130.634121464548;4311.33174357975;4347.239233134252;4497.325401189848;4535.433070866142;4652.97634520405;3689.29903318374;3766.7174961877968;3818.2172654606293;3821.2357528494413;3825.3114439401174;672.9899051514232;684.0764967294114;689.5276735436242;699.0667458942268;709.4005565297316;572.4332910418739;587.952963762898;628.5725706519519;668.4618881800101;672.7746205021373;9041;9389.76525586852;9418.811623767486;9544.856827147598;9549.61801527945;568.6076607141059;597.874446366268;621.0901029990995;662.1292999705469;682.443808296237;3838.5393752749846;4166.0834616384345;4634.95365046352;4698.530146985274;4727.57451829337;99110.5044474773;103240.48379758053;119361;167162;167483;106641;107533;109298.90701093046;121920.39039804744;142387.57612423744;102988;105938;109356;110540.44729776299;110995;9511.952440237754;9843;9972.252081094091;9984.35101718386;10044;46877;56533.71733141308;58288;58540.707296463246;58874.411255888605;83571.5821420889;86938.5653071756;86975;88670.55664721635;90238.54880725555;13204.537841175897;13252.933735331262;13303.26832024248;13326.200427974352;13368.933155334551;13928.58214253574;14446.855531444551;14936.775948361;15173.165475898932;15683.274839767844;11368.261063030877;13533.458661653818;13892.09470565601;14151.363188656329;14403;10669.306495077795;13833.86166138366;14218.217998010208;14248.931330150488;14389.424423022961;13088.869111308764;13309.134906231064;14159.64600884986;14188.787168192692;14641.414343426144;10235.385876847413;11470.483828227583;11513.942430287794;11730;11758.41261429696;8787.75178126777;10308.845367319345;10532.736071671448;10706.357618542912;10924.50839712199 14:23:55 INFO - PROCESS | 1650 | __end_tp_report 14:23:55 INFO - PROCESS | 1650 | __start_cc_report 14:23:55 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1464 14:23:55 INFO - PROCESS | 1650 | __end_cc_report 14:23:55 INFO - PROCESS | 1650 | __startTimestamp1477517035791__endTimestamp 14:23:55 INFO - PROCESS | 1650 | 14:23:55 INFO - PROCESS | 1650 | ------- Summary: start ------- 14:23:55 INFO - PROCESS | 1650 | Number of tests: 6 14:23:55 INFO - PROCESS | 1650 | 14:23:55 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5747.39 Median:5991.28 stddev:639.18 (10.7%) stddev-sans-first:613.26 14:23:55 INFO - PROCESS | 1650 | Values: 3367.3 3380.3 3414.2 3427.0 3458.0 5726.1 5729.1 5784.5 5837.6 5855.0 5721.1 5787.8 5789.2 5802.2 5810.1 5202.9 5241.6 5268.8 5270.8 5292.0 5168.0 5178.9 5197.9 5334.3 5355.3 5205.2 5267.6 5294.3 5294.9 5309.6 5249.4 5269.3 5279.4 5279.7 5292.4 5222.5 5242.9 5266.2 5267.8 5286.3 4615.8 4687.0 5639.3 5652.5 5816.3 6158.4 6184.4 6205.6 6212.7 6229.2 5500.7 6238.1 6257.9 6292.9 6321.5 5672.0 5739.8 5743.9 5859.6 5904.6 6177.6 6194.8 6224.7 6273.8 6286.3 6168.5 6172.5 6174.1 6185.8 6192.4 6125.6 6181.2 6235.5 6241.3 6251.2 6137.5 6197.6 6209.8 6210.5 6265.5 6221.2 6236.2 6271.3 6292.3 6294.2 4847.7 4913.6 4947.1 4951.8 4971.6 4372.7 4376.0 4435.3 4443.9 4449.7 5919.5 5925.8 5927.5 5929.1 5952.9 6260.7 6265.3 6269.1 6275.8 6288.1 5672.6 5688.6 5730.7 5787.5 5864.3 5390.8 5404.7 5432.9 5453.1 5479.7 5588.2 6230.0 6395.7 6424.4 6427.3 6090.1 6191.7 6270.6 6279.8 6290.7 5758.5 6232.9 6289.9 6350.2 6373.2 5139.8 6141.3 6159.2 6178.7 6189.6 6031.2 6247.2 6275.4 6314.8 6317.2 5965.0 6024.1 6067.2 6105.9 6162.8 6136.8 6153.9 6160.1 6162.7 6175.2 5991.9 6022.4 6044.9 6049.9 6054.8 6002.6 6046.6 6084.3 6154.4 6181.8 5925.7 5936.6 5991.3 6054.1 6067.2 14:23:55 INFO - PROCESS | 1650 | 14:23:55 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:80511.29 Median:37680.34 stddev:189491.29 (502.9%) stddev-sans-first:189927.59 14:23:55 INFO - PROCESS | 1650 | Values: 477.5 521.1 528.5 536.3 537.3 30615.5 41022.8 42213.0 42367.6 42416.6 43632.1 43919.3 43999.8 44033.8 44132.0 9739.8 9921.0 9938.5 9941.5 9956.7 8631.8 8834.7 8839.9 8957.0 9745.9 8993.8 11939.6 12195.9 12206.7 12462.0 12098.7 12174.5 12180.9 12183.1 12189.7 11847.3 11935.5 11946.0 11952.5 11956.7 40014.8 40352.8 40380.0 40517.2 40565.8 3426.6 3431.7 3469.4 3578.6 3683.4 30314.5 31134.4 31449.8 31586.8 32160.4 3085.1 3183.4 3204.7 3257.2 3277.1 542119.0 545296.0 546114.0 547206.0 547245.0 63425.0 64095.4 64162.7 64274.0 64312.7 34759.8 35101.1 35478.3 36656.0 36743.0 16980.7 17108.4 17123.7 17134.5 17137.3 13074.7 13075.0 13107.1 13116.7 13120.6 16567.9 16875.1 19333.6 19352.4 19361.7 6555.4 7727.7 7779.8 7781.7 7852.4 846.4 927.3 975.2 1008.7 1011.6 28616.6 29512.9 30391.2 30990.2 31013.7 1075.7 1076.4 1078.1 1101.5 1124.0 15201.8 15610.5 15725.5 15822.4 16078.4 739109.0 741225.0 741789.0 743216.0 747637.0 49478.3 50623.0 56397.4 57862.4 58354.0 1340.6 1351.4 1384.4 1385.9 1396.0 29994.4 31247.8 31536.4 31682.2 32315.8 50818.2 51409.7 51416.5 51478.2 51562.2 687526.0 697401.0 698765.0 934768.0 934839.0 41221.8 41541.6 41681.6 42027.0 42212.8 43515.3 45155.5 45436.5 45515.3 45876.0 37534.2 38060.2 38600.0 38729.4 39784.8 37327.6 37757.6 37803.0 38086.2 39379.8 30248.0 37656.6 37704.1 39559.0 39583.0 29101.7 33195.3 34441.7 35367.3 35522.9 26071.6 26106.6 26112.2 26219.0 26448.3 14:23:55 INFO - PROCESS | 1650 | 14:23:55 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:35014.96 Median:1386.13 stddev:102254.61 (7377.0%) stddev-sans-first:102508.32 14:23:55 INFO - PROCESS | 1650 | Values: 344.8 368.1 377.2 383.3 406.5 15095.7 15115.5 16828.7 20838.5 21514.7 19848.1 20313.4 20608.9 20745.4 20772.9 5349.7 5596.7 5598.8 5639.3 5662.2 5912.3 6078.8 6099.8 6105.6 6108.5 5800.2 6042.8 6052.5 6059.4 6065.9 6075.6 6087.5 6110.8 6117.5 6122.9 5192.6 5403.8 5459.8 5563.7 5895.9 12958.2 13079.0 13145.3 13158.5 13204.3 2055.7 2212.9 2242.3 2243.2 2427.5 9642.3 9699.4 10350.3 10947.9 15798.3 1552.7 1659.7 1791.6 1834.7 1838.4 111660.0 117793.0 117804.0 118706.8 120725.0 10506.5 11576.8 11718.0 11756.6 11997.0 14953.5 14958.0 14959.4 14972.9 14977.6 7942.7 8069.4 8129.6 8193.2 8202.1 7717.6 7742.0 7752.7 7807.0 7851.9 3849.4 4468.0 4539.4 4560.1 4653.0 1857.7 1914.7 1917.3 1926.3 1944.7 813.7 845.5 884.7 922.6 943.2 19908.6 20364.8 20448.5 20532.7 20741.2 897.4 934.9 946.8 954.4 967.4 10200.6 10440.9 10469.8 10896.8 10942.4 596165.0 607770.0 607865.0 620994.0 626417.0 131890.0 133097.0 134459.0 136211.3 137411.0 958.5 974.5 996.5 1017.4 1019.4 17419.0 18219.9 18553.4 18602.5 18676.5 50008.2 50225.5 50430.7 52938.7 54436.0 71872.0 76337.9 79279.2 81003.6 81509.0 7971.3 7996.6 8012.6 8269.7 8269.9 10041.5 10826.5 12196.1 12786.7 13115.3 4372.7 5144.1 9865.9 10843.5 11232.5 10642.7 10846.8 10995.2 11454.3 11492.5 11415.2 11450.2 11519.9 11695.6 11903.3 8059.3 8193.5 8248.4 8525.8 8691.6 8368.2 11146.6 11210.6 11615.2 11748.1 14:23:55 INFO - PROCESS | 1650 | 14:23:55 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5737.01 Median:4963.14 stddev:3258.33 (65.7%) stddev-sans-first:3250.53 14:23:55 INFO - PROCESS | 1650 | Values: 1316.3 1378.7 1459.6 1622.5 1858.1 7921.4 8501.1 8504.6 8505.7 8506.5 8281.6 8689.4 8911.4 8912.0 9109.4 2036.8 2390.4 2417.3 2417.6 2419.2 2351.2 2389.2 2400.7 2402.2 2406.8 2357.2 2384.8 2389.8 2399.4 2401.3 2340.1 2357.4 2370.3 2373.3 2379.3 2342.4 2375.2 2375.8 2377.0 2380.0 8885.5 9115.4 9119.8 9126.5 9149.9 5197.2 5244.6 5402.5 5404.2 5425.2 3546.8 3641.6 3719.3 3732.0 3746.0 1086.7 1090.0 1091.2 1100.4 1114.0 10311.4 12139.0 12247.6 12259.6 12290.4 4003.7 4489.0 4624.1 4681.1 4723.5 9420.9 9424.8 9434.8 9440.2 9464.3 5299.2 5300.3 5302.8 5304.8 5326.9 4129.6 4414.5 4443.4 4558.9 4945.6 3159.2 3317.4 3841.2 3918.0 3922.0 1061.3 1107.8 1142.3 1143.5 1164.4 777.9 786.4 926.1 934.6 951.6 5871.3 5880.8 5881.9 6024.8 6164.3 425.5 959.9 978.8 987.1 1038.5 3884.8 3958.2 3972.0 4017.2 4108.8 10756.2 11012.3 11092.4 11110.3 11148.6 10997.3 11012.1 11013.3 11084.5 11085.0 6717.9 8332.7 8342.0 8490.7 8491.2 5944.3 5993.8 6023.1 6110.9 6200.6 9272.6 10044.8 10307.4 10368.5 10387.9 9467.4 10081.9 10451.7 10545.9 10574.7 7207.3 7413.8 7421.7 7422.4 7424.2 7513.7 8288.4 8293.5 8447.4 8510.0 7739.4 7746.0 7795.2 7801.1 7801.2 7530.7 7553.2 7561.0 7699.1 7769.0 6999.2 7034.5 7073.0 7121.2 7142.0 4957.9 4968.4 5076.9 5111.5 5237.3 5001.7 5026.7 5107.2 5155.0 5310.1 14:23:55 INFO - PROCESS | 1650 | 14:23:55 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4406.70 Median:4836.62 stddev:1359.94 (28.1%) stddev-sans-first:1328.14 14:23:55 INFO - PROCESS | 1650 | Values: 286.9 296.3 301.7 306.9 308.5 4469.4 4701.9 4848.9 5054.7 5322.2 4826.1 4925.8 5014.9 5016.4 5218.4 3630.6 4038.5 4044.1 4049.7 4088.0 3177.7 4022.3 4024.2 4036.3 4085.8 3363.6 3968.8 4020.1 4059.9 4075.4 4023.9 4032.0 4055.5 4056.6 4068.2 2664.0 3152.9 3476.5 3495.8 3521.3 4365.7 4689.4 4734.4 4795.8 5155.3 4387.8 4563.6 4587.9 4598.2 4636.0 4810.9 5385.2 5386.4 5481.7 5489.6 3205.8 3386.6 3672.5 3850.3 3870.6 5160.9 5515.8 5527.0 5724.5 5967.9 3278.4 3282.3 3919.6 3933.0 3941.0 3922.9 3963.0 3967.2 3987.5 4003.4 4063.5 4427.9 4473.0 4558.4 4654.8 4668.5 5437.5 5481.3 5495.5 5588.4 1122.9 1159.1 1183.9 1285.4 1349.0 843.0 874.7 883.8 893.8 922.5 5199.8 5249.3 5264.5 5309.9 5317.3 4754.7 4934.8 4990.8 4994.8 5496.7 4386.7 4467.2 4728.8 4934.9 5242.5 2601.7 2681.4 2763.3 2860.3 2991.4 4916.4 4959.5 5792.6 5815.3 5892.5 5423.5 5663.5 5704.5 5805.8 5833.9 5114.6 5868.4 5894.7 5912.4 5922.0 4383.8 5056.8 5412.9 5602.7 5638.7 5011.3 5472.2 5656.2 5738.8 5758.3 4589.5 4847.2 5081.5 5981.9 6066.9 3300.6 3619.3 3632.0 3811.9 3853.9 4743.3 5110.4 5459.8 5476.9 5853.2 5696.3 5705.1 5713.7 5718.5 5728.6 4618.4 4622.0 4876.0 4881.4 5558.1 4581.1 5136.7 5137.5 5433.6 5457.5 5049.3 5347.8 5416.7 5542.2 5583.2 4652.0 4666.0 5484.7 5539.9 5563.4 14:23:55 INFO - PROCESS | 1650 | 14:23:55 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:23928.42 Median:3792.47 stddev:37451.01 (987.5%) stddev-sans-first:37515.21 14:23:55 INFO - PROCESS | 1650 | Values: 630.9 710.8 775.9 787.8 815.6 15241.5 16421.2 16430.4 16433.3 16468.6 14128.8 14166.9 14182.7 14215.4 14271.8 645.3 669.0 674.7 756.8 771.7 810.4 819.4 836.9 840.8 841.9 883.5 887.5 887.8 887.8 888.7 688.6 708.1 882.5 883.5 883.9 635.9 648.8 654.0 657.2 657.7 15154.5 15194.8 15231.4 15248.3 15252.7 13800.0 13810.5 13946.7 14040.9 14100.9 12540.6 12692.0 12837.3 12857.5 13353.4 4462.1 4513.5 4572.4 4583.0 4728.3 110402.9 110795.9 115647.8 117144.4 117274.0 10432.3 10900.7 11193.1 11381.0 11505.1 20778.8 21716.9 22470.0 22726.0 22745.2 8052.8 8076.8 8110.0 8126.3 8130.6 4311.3 4347.2 4497.3 4535.4 4653.0 3689.3 3766.7 3818.2 3821.2 3825.3 673.0 684.1 689.5 699.1 709.4 572.4 588.0 628.6 668.5 672.8 9041.0 9389.8 9418.8 9544.9 9549.6 568.6 597.9 621.1 662.1 682.4 3838.5 4166.1 4635.0 4698.5 4727.6 99110.5 103240.5 119361.0 167162.0 167483.0 106641.0 107533.0 109298.9 121920.4 142387.6 102988.0 105938.0 109356.0 110540.4 110995.0 9512.0 9843.0 9972.3 9984.4 10044.0 46877.0 56533.7 58288.0 58540.7 58874.4 83571.6 86938.6 86975.0 88670.6 90238.5 13204.5 13252.9 13303.3 13326.2 13368.9 13928.6 14446.9 14936.8 15173.2 15683.3 11368.3 13533.5 13892.1 14151.4 14403.0 10669.3 13833.9 14218.2 14248.9 14389.4 13088.9 13309.1 14159.6 14188.8 14641.4 10235.4 11470.5 11513.9 11730.0 11758.4 8787.8 10308.8 10532.7 10706.4 10924.5 14:23:55 INFO - PROCESS | 1650 | -------- Summary: end -------- 14:23:55 INFO - PROCESS | 1650 | 14:23:56 INFO - TEST-INFO | 1650: exit 0 14:23:56 INFO - TEST-OK | dromaeo_css | took 1117269ms 14:23:56 INFO - TEST-START | kraken 14:23:56 INFO - operating with platform_type : mac_ 14:23:56 INFO - Initialising browser for kraken test... 14:23:56 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpnzF4LN/profile http://localhost:49267/getInfo.html) 14:23:58 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 14:23:58 INFO - PROCESS | 1660 | colorDepth:24 14:23:58 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 14:23:58 INFO - PROCESS | 1660 | __metrics 14:23:58 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:23:58 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:59 INFO - TEST-INFO | 1660: exit 0 14:23:59 INFO - Browser initialized. 14:23:59 INFO - Running cycle 1/1 for kraken test... 14:23:59 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpnzF4LN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:11 INFO - PROCESS | 1662 | RSS: Main: 219090944 14:24:11 INFO - PROCESS | 1662 | 14:24:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 14:24:15 INFO - PROCESS | 1662 | RSS: Main: 269144064 14:24:15 INFO - PROCESS | 1662 | 14:24:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 14:24:18 INFO - PROCESS | 1662 | RSS: Main: 279543808 14:24:18 INFO - PROCESS | 1662 | 14:24:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 14:24:22 INFO - PROCESS | 1662 | RSS: Main: 377790464 14:24:22 INFO - PROCESS | 1662 | 14:24:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 14:24:24 INFO - PROCESS | 1662 | RSS: Main: 279941120 14:24:24 INFO - PROCESS | 1662 | 14:24:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:27 INFO - PROCESS | 1662 | RSS: Main: 280776704 14:24:27 INFO - PROCESS | 1662 | 14:24:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:31 INFO - PROCESS | 1662 | RSS: Main: 319078400 14:24:31 INFO - PROCESS | 1662 | 14:24:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:34 INFO - PROCESS | 1662 | RSS: Main: 318726144 14:24:34 INFO - PROCESS | 1662 | 14:24:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 14:24:37 INFO - PROCESS | 1662 | RSS: Main: 318369792 14:24:37 INFO - PROCESS | 1662 | 14:24:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:40 INFO - PROCESS | 1662 | RSS: Main: 290832384 14:24:40 INFO - PROCESS | 1662 | 14:24:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:24:42 INFO - PROCESS | 1662 | RSS: Main: 295866368 14:24:42 INFO - PROCESS | 1662 | 14:24:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:24:45 INFO - PROCESS | 1662 | RSS: Main: 299749376 14:24:45 INFO - PROCESS | 1662 | 14:24:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:24:49 INFO - PROCESS | 1662 | RSS: Main: 311070720 14:24:49 INFO - PROCESS | 1662 | 14:24:51 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:24:52 INFO - PROCESS | 1662 | RSS: Main: 310702080 14:24:52 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 14:24:54 INFO - PROCESS | 1662 | RSS: Main: 354942976 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | __start_tp_report 14:24:54 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 14:24:54 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 14:24:54 INFO - PROCESS | 1662 | |i|pagename|runs| 14:24:54 INFO - PROCESS | 1662 | |0;ai-astar;114;116;115;114;115;114;114;114;113;113 14:24:54 INFO - PROCESS | 1662 | |1;audio-beat-detection;140;109;117;172;115;107;111;106;139;108 14:24:54 INFO - PROCESS | 1662 | |2;audio-dft;184;184;183;185;183;181;185;183;183;184 14:24:54 INFO - PROCESS | 1662 | |3;audio-fft;82;60;60;87;61;58;58;60;85;69 14:24:54 INFO - PROCESS | 1662 | |4;audio-oscillator;88;72;93;73;68;69;92;68;68;90 14:24:54 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;90;87;90;87;90;87;90;88;90;130 14:24:54 INFO - PROCESS | 1662 | |6;imaging-darkroom;97;98;99;98;97;98;98;98;96;98 14:24:54 INFO - PROCESS | 1662 | |7;imaging-desaturate;86;84;84;84;84;85;86;85;82;87 14:24:54 INFO - PROCESS | 1662 | |8;json-parse-financial;57;54;53;53;55;57;56;56;56;57 14:24:54 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;64;72;72;73;75;68;69;68;70;70 14:24:54 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;84;83;91;98;85;84;81;85;83;83 14:24:54 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;142;139;140;138;139;140;143;150;173;153 14:24:54 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;169;165;164;164;163;167;164;163;163;161 14:24:54 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;67;66;67;67;66;67;66;66;67;67 14:24:54 INFO - PROCESS | 1662 | __end_tp_report 14:24:54 INFO - PROCESS | 1662 | __start_cc_report 14:24:54 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2004 14:24:54 INFO - PROCESS | 1662 | __end_cc_report 14:24:54 INFO - PROCESS | 1662 | __startTimestamp1477517094543__endTimestamp 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | ------- Summary: start ------- 14:24:54 INFO - PROCESS | 1662 | Number of tests: 14 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 14:24:54 INFO - PROCESS | 1662 | Values: 114.0 116.0 115.0 114.0 115.0 114.0 114.0 114.0 113.0 113.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:122.40 Median:116.00 stddev:21.48 (18.5%) stddev-sans-first:21.82 14:24:54 INFO - PROCESS | 1662 | Values: 140.0 109.0 117.0 172.0 115.0 107.0 111.0 106.0 139.0 108.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.18 (0.6%) stddev-sans-first:1.24 14:24:54 INFO - PROCESS | 1662 | Values: 184.0 184.0 183.0 185.0 183.0 181.0 185.0 183.0 183.0 184.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:68.00 Median:65.00 stddev:11.96 (18.4%) stddev-sans-first:11.57 14:24:54 INFO - PROCESS | 1662 | Values: 82.0 60.0 60.0 87.0 61.0 58.0 58.0 60.0 85.0 69.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:80.50 stddev:11.09 (13.8%) stddev-sans-first:11.17 14:24:54 INFO - PROCESS | 1662 | Values: 88.0 72.0 93.0 73.0 68.0 69.0 92.0 68.0 68.0 90.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:92.90 Median:90.00 stddev:13.11 (14.6%) stddev-sans-first:13.86 14:24:54 INFO - PROCESS | 1662 | Values: 90.0 87.0 90.0 87.0 90.0 87.0 90.0 88.0 90.0 130.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:98.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 14:24:54 INFO - PROCESS | 1662 | Values: 97.0 98.0 99.0 98.0 97.0 98.0 98.0 98.0 96.0 98.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.42 (1.7%) stddev-sans-first:1.42 14:24:54 INFO - PROCESS | 1662 | Values: 86.0 84.0 84.0 84.0 84.0 85.0 86.0 85.0 82.0 87.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.58 (2.8%) stddev-sans-first:1.56 14:24:54 INFO - PROCESS | 1662 | Values: 57.0 54.0 53.0 53.0 55.0 57.0 56.0 56.0 56.0 57.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:3.11 (4.4%) stddev-sans-first:2.39 14:24:54 INFO - PROCESS | 1662 | Values: 64.0 72.0 72.0 73.0 75.0 68.0 69.0 68.0 70.0 70.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.50 stddev:5.06 (6.0%) stddev-sans-first:5.33 14:24:54 INFO - PROCESS | 1662 | Values: 84.0 83.0 91.0 98.0 85.0 84.0 81.0 85.0 83.0 83.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:142.50 stddev:10.81 (7.6%) stddev-sans-first:11.38 14:24:54 INFO - PROCESS | 1662 | Values: 142.0 139.0 140.0 138.0 139.0 140.0 143.0 150.0 173.0 153.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.00 stddev:2.26 (1.4%) stddev-sans-first:1.64 14:24:54 INFO - PROCESS | 1662 | Values: 169.0 165.0 164.0 164.0 163.0 167.0 164.0 163.0 163.0 161.0 14:24:54 INFO - PROCESS | 1662 | 14:24:54 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 14:24:54 INFO - PROCESS | 1662 | Values: 67.0 66.0 67.0 67.0 66.0 67.0 66.0 66.0 67.0 67.0 14:24:54 INFO - PROCESS | 1662 | -------- Summary: end -------- 14:24:54 INFO - PROCESS | 1662 | 14:24:55 INFO - TEST-INFO | 1662: exit 0 14:24:55 INFO - TEST-OK | kraken | took 58982ms 14:24:55 INFO - SUITE-END | took 1176s 14:24:55 INFO - Completed test suite (00:19:36) 14:24:55 INFO - javascript benchmark 14:24:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.2760356523345, 3380.2901390707943, 3414.2317978454853, 3427.0, 3458.0, 5726.083826587746, 5729.0833466645345, 5784.537237021039, 5837.649741015542, 5855.033919403299, 5721.141828725693, 5787.768489260425, 5789.189513468107, 5802.158686990384, 5810.128480727893, 5202.8699282518055, 5241.606879484035, 5268.789248430077, 5270.789168433258, 5291.973540132313, 5168.0, 5178.896422071556, 5197.896042079156, 5334.306540149794, 5355.303810504629, 5205.193195054772, 5267.55225805807, 5294.311739473882, 5294.92057619136, 5309.62832601718, 5249.396319423239, 5269.2623032775255, 5279.392869819982, 5279.6832190068335, 5292.44429334922, 5222.529972302511, 5242.947570524284, 5266.1574148136115, 5267.815626453094, 5286.286351342558, 4615.792289346988, 4687.0, 5639.2668953036255, 5652.5195358394585, 5816.331121920949, 6158.384161583851, 6184.412480814315, 6205.565610407273, 6212.65830379329, 6229.221347331583, 5500.669959802424, 6238.054126348038, 6257.87484250317, 6292.905606415908, 6321.494280457552, 5671.971640141773, 5739.799107031234, 5743.93737158627, 5859.589828711992, 5904.645721256738, 6177.598456100339, 6194.81415557534, 6224.657643829542, 6273.843153921189, 6286.277078136073, 6168.537359698041, 6172.475339596095, 6174.073888916609, 6185.8144255672405, 6192.380761923861, 6125.632272693312, 6181.227346581677, 6235.469985051231, 6241.251049874044, 6251.218597675291, 6137.4995631051315, 6197.566170368031, 6209.844753881189, 6210.472109870621, 6265.530085243534, 6221.160143380585, 6236.158118653923, 6271.278802937721, 6292.276388215322, 6294.213223347082, 4847.684900481458, 4913.582345500672, 4947.134251505972, 4951.777170027357, 4971.577415919615, 4372.672049596293, 4375.978120109379, 4435.290353543418, 4443.933340999887, 4449.733016018984, 5919.467247947619, 5925.792597259076, 5927.4665280125, 5929.14027466015, 5952.940470595326, 6260.718267677966, 6265.342139075423, 6269.059641053878, 6275.811725648238, 6288.088227207029, 5672.631278966854, 5688.601797874109, 5730.656160630376, 5787.479126878601, 5864.325602555676, 5390.838274851761, 5404.675719456845, 5432.864178395572, 5453.072977593819, 5479.698616576126, 5588.21764952907, 6229.96885015572, 6395.744170233139, 6424.357564243538, 6427.260865000491, 6090.116933044772, 6191.659458729633, 6270.561060725706, 6279.843003924939, 6290.748370065146, 5758.452946970031, 6232.937670623236, 6289.905651415141, 6350.174477317919, 6373.203349581302, 5139.8458046258675, 6141.301904043499, 6159.168512250789, 6178.66017369049, 6189.597676151036, 6031.185789918305, 6247.219097612799, 6275.3724627536885, 6314.778982735582, 6317.210348706411, 5965.0, 6024.096385542204, 6067.150598916067, 6105.908411373922, 6162.784302549569, 6136.764169924236, 6153.938460615336, 6160.075988601567, 6162.722677479614, 6175.166352542349, 5991.921454138297, 6022.36765139654, 6044.909326360196, 6049.939500604937, 6054.8183554493435, 6002.609830361187, 6046.637201767908, 6084.330723620486, 6154.353792851865, 6181.81454556364, 5925.674087925033, 5936.554758393224, 5991.281046274301, 6054.091886217103, 6067.24159480065], "value": 5707.629515597645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.5153219482226, 521.0542864700568, 528.5322489596708, 536.3376230355512, 537.2639483907047, 30615.540766888513, 41022.794886025564, 42213.0, 42367.57632423679, 42416.575834241645, 43632.12735745283, 43919.3412098818, 43999.78000109995, 44033.7798311008, 44132.0, 9739.756506087351, 9920.950395248014, 9938.503074846265, 9941.502924853728, 9956.701298961007, 8631.784205394853, 8834.690785822497, 8839.911600883974, 8956.955215223947, 9745.90254097457, 8993.775155621097, 11939.58211462599, 12195.878041219607, 12206.694832629211, 12462.003039756797, 12098.697532561713, 12174.513019479211, 12180.878191218064, 12183.086268529807, 12189.695257618541, 11847.348395838226, 11935.462904169333, 11946.0, 11952.462139203757, 11956.701082473008, 40014.799556013364, 40352.79823600863, 40380.0, 40517.189656207, 40565.79717101395, 3426.6059403168706, 3431.656834316548, 3469.3755124077657, 3578.58846232684, 3683.4290684943876, 30314.54528182079, 31134.37731245385, 31449.842750786327, 31586.842065789755, 32160.356792864244, 3085.1053194573547, 3183.4110689522513, 3204.743620510377, 3257.218267615755, 3277.115178901683, 542119.0, 545296.0, 546113.999999996, 547206.0, 547245.0, 63425.0, 64095.359046409874, 64162.67918660377, 64274.035889461695, 64312.678436607515, 34759.82620086883, 35101.122471938404, 35478.29043419117, 36656.0, 36743.0, 16980.74528882068, 17108.401205957733, 17123.657526849394, 17134.485965421056, 17137.314507419815, 13074.738505229841, 13075.0, 13107.14803537767, 13116.672083197805, 13120.60638180856, 16567.917160414363, 16875.071871046966, 19333.61332773337, 19352.4194274172, 19361.709574356395, 6555.410013098844, 7727.729529466442, 7779.805504862424, 7781.727639532589, 7852.411069169835, 846.4075147396846, 927.3462209142539, 975.1857199238574, 1008.7138897905083, 1011.5751384418414, 28616.570751438747, 29512.852435737685, 30391.24021899426, 30990.22524436862, 31013.68986310108, 1075.6772968109535, 1076.424113099488, 1078.0674716370283, 1101.4878081692052, 1124.0333313350511, 15201.771973420407, 15610.517000885126, 15725.528234152993, 15822.446214382442, 16078.437254696264, 739109.0, 741225.0, 741789.0, 743216.0, 747637.0, 49478.257826132634, 50623.0, 56397.43602564004, 57862.421375786544, 58354.0, 1340.6380277325068, 1351.3783659516537, 1384.3770303363326, 1385.861413858606, 1396.0018586710348, 29994.434063531327, 31247.843760781052, 31536.369272614877, 31682.207944801565, 32315.838420807744, 50818.23772643339, 51409.74295128501, 51416.48583514117, 51478.22782658188, 51562.22656660078, 687526.0, 697401.0, 698765.0, 934768.0, 934839.0, 41221.76334709964, 41541.584584153774, 41681.58318416777, 42027.0, 42212.78893605512, 43515.347269791615, 45155.54844451514, 45436.54563454323, 45515.317270241634, 45876.0, 37534.249315014094, 38060.2387952245, 38600.0, 38729.4190587147, 39784.80107599444, 37327.626723732414, 37757.622423775414, 37803.0, 38086.23827523379, 39379.80310098431, 30248.0, 37656.623433765315, 37704.05739856416, 39559.0, 39583.0, 29101.7089829099, 33195.33609327752, 34441.65558344385, 35367.29265414626, 35522.93431197068, 26071.608925866505, 26106.60840087362, 26112.216633501026, 26219.0, 26448.338791530365], "value": 20691.226415002024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.79140120227277, 368.08714388316974, 377.15329086201484, 383.2756090988032, 406.46955722781775, 15095.698086038272, 15115.470958516455, 16828.66342673146, 20838.47903802402, 21514.677279840816, 19848.106835192415, 20313.39059828204, 20608.8969555152, 20745.377638670827, 20772.896135519302, 5349.652272602279, 5596.720163991784, 5598.776048958037, 5639.295088113986, 5662.17898404731, 5912.320083190445, 6078.848028799272, 6099.847503812396, 6105.572609917308, 6108.541859360544, 5800.158976948361, 6042.788502402417, 6052.455279024887, 6059.3637668044885, 6065.939340606582, 6075.574709770318, 6087.543434242428, 6110.755569777203, 6117.541184411187, 6122.8775424491705, 5192.636515443921, 5403.8108666196495, 5459.781608735646, 5563.666180029211, 5895.941040589582, 12958.22250664963, 13079.0, 13145.342732863413, 13158.473661053546, 13204.273764942924, 2055.6813693877325, 2212.9446763830874, 2242.3273018094505, 2243.2372993182234, 2427.4659574893494, 9642.325037247396, 9699.369540979813, 10350.327228730108, 10947.890521094767, 15798.289076991563, 1552.6972240413124, 1659.6846599146124, 1791.570023194437, 1834.7431359609666, 1838.4025191812714, 111660.0, 117793.0, 117804.0, 118706.81293187045, 120725.0, 10506.527206275736, 11576.768464630828, 11718.0, 11756.647300580997, 11997.0, 14953.476628317956, 14958.027728197632, 14959.401623935139, 14972.850271497364, 14977.625559360886, 7942.682292708342, 8069.394795390369, 8129.552874591836, 8193.180681931759, 8202.138775428613, 7717.57553334572, 7742.032245969254, 7752.7286544971785, 7806.960965195138, 7851.900733897259, 3849.3840985442193, 4468.017036252019, 4539.387182730356, 4560.065186636732, 4652.976735116303, 1857.7399164117035, 1914.7032210007471, 1917.3481016454473, 1926.2969016308946, 1944.6596845551971, 813.7477382011596, 845.5476320168681, 884.6638277454526, 922.5756152170077, 943.1558754914313, 19908.60182796336, 20364.796352036585, 20448.465151304943, 20532.692009619568, 20741.170353186004, 897.3583887520324, 934.9158575728217, 946.8390373636498, 954.398728800851, 967.4340510801119, 10200.591976321013, 10440.947795261127, 10469.790604188025, 10896.78206435867, 10942.398168100832, 596165.0, 607770.0, 607865.0, 620994.0, 626417.0, 131890.0, 133097.0, 134459.0, 136211.31894340465, 137411.0, 958.5399008475971, 974.4835237324229, 996.4668902137466, 1017.4404077757204, 1019.4036488654073, 17419.0, 18219.90890045541, 18553.35063272779, 18602.534936626693, 18676.533086672942, 50008.249876252616, 50225.49774502208, 50430.747846260536, 52938.735306324765, 54436.0, 71872.0, 76337.85493217495, 79279.20720792719, 81003.59498202472, 81509.0, 7971.3224375926375, 7996.56018918965, 8012.599370031592, 8269.71819367999, 8269.875951860606, 10041.523217524802, 10826.512806923865, 12196.146269761031, 12786.744265114832, 13115.27865967381, 4372.737635741865, 5144.125498665311, 9865.852012219966, 10843.481912532094, 11232.494537745984, 10642.680719578426, 10846.783064338511, 10995.230333876552, 11454.255473394203, 11492.54029838797, 11415.200935934738, 11450.198486105892, 11519.942400287944, 11695.590654327398, 11903.345316007702, 8059.274665280153, 8193.50838949665, 8248.422610417214, 8525.786855328666, 8691.608877600649, 8368.24685778283, 11146.55413783472, 11210.55157793679, 11615.245009074382, 11748.118891083373], "value": 9238.279922937127, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.2694704439032, 1378.689794796171, 1459.5767227504025, 1622.4889159914626, 1858.0709645177403, 7921.366290696737, 8501.107383724713, 8504.574771261443, 8505.659773609055, 8506.489610623352, 8281.627326770295, 8689.391742578022, 8911.376203665746, 8912.0, 9109.40788848726, 2036.786137455568, 2390.3904504351367, 2417.347316224618, 2417.601095819188, 2419.177479656916, 2351.235848349285, 2389.1637926725593, 2400.663907053014, 2402.1832576923844, 2406.8074554035725, 2357.210334537932, 2384.821138414617, 2389.796867266276, 2399.400149962509, 2401.315625046862, 2340.0639744102323, 2357.35172827473, 2370.3363058343693, 2373.3354660695118, 2379.262428647125, 2342.3675607585856, 2375.1568193291305, 2375.786179243876, 2377.0, 2379.964300535476, 8885.4668719877, 9115.361924665276, 9119.772005699844, 9126.498042607654, 9149.862752058725, 5197.220416937452, 5244.580433565306, 5402.486763757437, 5404.243405923174, 5425.240466334716, 3546.840392182358, 3641.6176301488226, 3719.2933342664805, 3732.0, 3746.0260332313524, 1086.6957251969461, 1090.0407641275706, 1091.165258577189, 1100.350793032115, 1113.9665810025713, 10311.381317120997, 12139.028877689852, 12247.571335003233, 12259.570915017932, 12290.385480725929, 4003.679705623543, 4489.012417268195, 4624.1445332613575, 4681.133990211822, 4723.504032076651, 9420.858687119699, 9424.811503769886, 9434.764130896783, 9440.24478041755, 9464.337496375325, 5299.152135658276, 5300.337457817773, 5302.787888484495, 5304.840854774363, 5326.9467305327225, 4129.607687269705, 4414.470263568328, 4443.400140980926, 4558.908821823545, 4945.604351651859, 3159.210197450637, 3317.4360358739073, 3841.2317536492255, 3917.9822391468415, 3921.9998900280248, 1061.3472714280815, 1107.8091052119005, 1142.308903113621, 1143.5482984221187, 1164.3886959346412, 777.9105402878628, 786.3591173193829, 926.129438327983, 934.5747684803398, 951.6003278622857, 5871.32479764824, 5880.8235752927485, 5881.852953676193, 6024.759009639653, 6164.260288765377, 425.5149129991812, 959.8752162218867, 978.7699890525721, 987.0573602209872, 1038.4859494550094, 3884.786336751449, 3958.188571342868, 3972.0, 4017.1563971566297, 4108.77401742901, 10756.247062705692, 11012.284201526874, 11092.445377731081, 11110.277831940897, 11148.609798657008, 10997.285176463663, 11012.119030477543, 11013.2841365311, 11084.501197446134, 11085.002349788558, 6717.932820671828, 8332.66669333232, 8342.040665323444, 8490.745277641681, 8491.15088491146, 5944.256967879015, 5993.820185394445, 6023.066424704178, 6110.938890611214, 6200.596961197508, 9272.629094836131, 10044.844842843166, 10307.433091180057, 10368.481575921325, 10387.94806025965, 9467.431954082776, 10081.949590252296, 10451.738706532093, 10545.9472702636, 10574.735631608964, 7207.315305046012, 7413.8146546336775, 7421.740239091606, 7422.369098626677, 7424.220456852169, 7513.737019204302, 8288.419810613199, 8293.502389856629, 8447.408681392244, 8510.021347545111, 7739.419543534144, 7746.0, 7795.22047795216, 7801.102873169658, 7801.1808760079375, 7530.6611202497115, 7553.206913274247, 7560.986500364488, 7699.076110866732, 7769.0, 6999.195092564217, 7034.472414568825, 7073.0, 7121.216666166614, 7141.9642901785155, 4957.876053098701, 4968.403791545038, 5076.873078173076, 5111.488851114858, 5237.292965449616, 5001.749912504433, 5026.748662566784, 5107.157319042316, 5154.994776018641, 5310.070737620978], "value": 4575.430771924255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.93543952610656, 296.3110767465643, 301.7359810166105, 306.940146671399, 308.5187108111348, 4469.396631454757, 4701.85894423167, 4848.8787780305465, 5054.671446355985, 5322.2282768998475, 4826.069572171134, 4925.82759603414, 5014.874628134289, 5016.398032236128, 5218.425973142951, 3630.5824830144475, 4038.474998250238, 4044.0992733415324, 4049.6760259179196, 4087.9591204088024, 3177.7298929590897, 4022.255882661717, 4024.235395274903, 4036.3340048891896, 4085.754854708727, 3363.6131844837914, 3968.7973174887925, 4020.115574573589, 4059.8632382932824, 4075.4498142750795, 4023.8591649292134, 4031.9596804031876, 4055.4727885374714, 4056.6146216109423, 4068.247374235776, 2664.0276299150864, 3152.858121384543, 3476.5480487536456, 3495.842687079062, 3521.2605352875926, 4365.738055716667, 4689.437267527885, 4734.431868175807, 4795.784189711437, 5155.32980712505, 4387.811854441455, 4563.612092972101, 4587.912499812577, 4598.218302888517, 4636.0, 4810.85567432974, 5385.246065550826, 5386.4074951755665, 5481.671099734029, 5489.58828087891, 3205.8076515408916, 3386.6444023377435, 3672.467492213614, 3850.3261929162563, 3870.59358767331, 5160.92258616121, 5515.814099968486, 5526.977509160858, 5724.484796368305, 5967.850803729942, 3278.4098862205033, 3282.343531293751, 3919.568847426781, 3932.9606703932595, 3941.0, 3922.882313530599, 3962.968329228143, 3967.1867267210155, 3987.541432735273, 4003.3794761811964, 4063.4717486726536, 4427.933580996288, 4472.971216620195, 4558.384618076583, 4654.767261636905, 4668.533146685372, 5437.483439073281, 5481.342238931354, 5495.53287970519, 5588.3573389060775, 1122.8989390954853, 1159.0727418065683, 1183.9348835814112, 1285.363744946239, 1348.9730205395838, 843.0347252395973, 874.7463235661587, 883.8188171424971, 893.7586851550045, 922.4972390047441, 5199.766010529535, 5249.317588713443, 5264.525932738839, 5309.867178364783, 5317.255584218213, 4754.667173297905, 4934.766308422894, 4990.750462476862, 4994.825181118644, 5496.735750777344, 4386.692931494765, 4467.15124126415, 4728.810847566127, 4934.9013019739405, 5242.475752424803, 2601.6747906511687, 2681.396685745731, 2763.2677340504783, 2860.270630989126, 2991.3718119195214, 4916.385451818523, 4959.454460009396, 5792.623479473821, 5815.3021637402935, 5892.469677729025, 5423.538999185034, 5663.461971112738, 5704.515116215168, 5805.796797112081, 5833.854153646193, 5114.616403769732, 5868.354481007086, 5894.67579283135, 5912.408759124053, 5922.0, 4383.824647014211, 5056.772445240046, 5412.945870541244, 5602.747876345656, 5638.689872057076, 5011.271111466538, 5472.2338872557075, 5656.238601330069, 5738.799142030009, 5758.337791154071, 4589.462530052469, 4847.175980083323, 5081.466446023114, 5981.850453738692, 6066.878662426639, 3300.62042865064, 3619.3123306571665, 3631.9636803632684, 3811.9237615248094, 3853.942190867195, 4743.312219728051, 5110.361204849394, 5459.836204913859, 5476.890462190813, 5853.239078919713, 5696.344920334214, 5705.087186050212, 5713.714314284352, 5718.456746609066, 5728.627639203439, 4618.4457865055065, 4621.976890115528, 4875.975620121877, 4881.438634556929, 5558.138488534284, 4581.083783243432, 5136.743162841918, 5137.51193636604, 5433.646812957145, 5457.481539253765, 5049.314000779525, 5347.812826551052, 5416.7270691388285, 5542.168674698827, 5583.1904373864745, 4652.022890271689, 4665.976670116764, 5484.698341591251, 5539.861503462284, 5563.360213575491], "value": 3974.133753894686, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.8864404407204, 710.7547895975887, 775.8952541406908, 787.8030492376906, 815.6411179081206, 15241.542753717378, 16421.178941052945, 16430.424935127274, 16433.260503277383, 16468.588285292873, 14128.788068178985, 14166.858331416683, 14182.71634567308, 14215.431382744679, 14271.78592321116, 645.3481983196981, 668.9899651505232, 674.6694119881272, 756.8004712530645, 771.6643260181811, 810.3760104719393, 819.397742659145, 836.9497830130211, 840.7687885831415, 841.9242268195861, 883.4964070479829, 887.4941283468426, 887.8046829697456, 887.8224355129, 888.6800751729372, 688.6178171115029, 708.1042481261157, 882.4749274181852, 883.4610887358738, 883.8939327280735, 635.8982562789978, 648.8442773734317, 654.035297935546, 657.1916542652516, 657.697459168783, 15154.469593564283, 15194.772078418833, 15231.390744370212, 15248.31382587775, 15252.694946101126, 13800.0, 13810.516631917935, 13946.721065578631, 14040.92979535106, 14100.92949535256, 12540.623781286577, 12692.0, 12837.29394883281, 12857.549985750455, 13353.399097040656, 4462.085272519158, 4513.50351461339, 4572.382728331666, 4582.991741816795, 4728.267118596623, 110402.89597104087, 110795.89204108017, 115647.84352156454, 117144.41427792891, 117274.0, 10432.2697411182, 10900.746414162315, 11193.097292472446, 11381.0, 11505.137114716263, 20778.792212077988, 21716.891415543138, 22470.0, 22726.0, 22745.203917862797, 8052.758417247492, 8076.757697269091, 8109.959450202829, 8126.309263712533, 8130.634121464548, 4311.33174357975, 4347.239233134252, 4497.325401189848, 4535.433070866142, 4652.97634520405, 3689.29903318374, 3766.7174961877968, 3818.2172654606293, 3821.2357528494413, 3825.3114439401174, 672.9899051514232, 684.0764967294114, 689.5276735436242, 699.0667458942268, 709.4005565297316, 572.4332910418739, 587.952963762898, 628.5725706519519, 668.4618881800101, 672.7746205021373, 9041.0, 9389.76525586852, 9418.811623767486, 9544.856827147598, 9549.61801527945, 568.6076607141059, 597.874446366268, 621.0901029990995, 662.1292999705469, 682.443808296237, 3838.5393752749846, 4166.0834616384345, 4634.95365046352, 4698.530146985274, 4727.57451829337, 99110.5044474773, 103240.48379758053, 119361.0, 167162.0, 167483.0, 106641.0, 107533.0, 109298.90701093046, 121920.39039804744, 142387.57612423744, 102988.0, 105938.0, 109356.0, 110540.44729776299, 110995.0, 9511.952440237754, 9843.0, 9972.252081094091, 9984.35101718386, 10044.0, 46877.0, 56533.71733141308, 58288.0, 58540.707296463246, 58874.411255888605, 83571.5821420889, 86938.5653071756, 86975.0, 88670.55664721635, 90238.54880725555, 13204.537841175897, 13252.933735331262, 13303.26832024248, 13326.200427974352, 13368.933155334551, 13928.58214253574, 14446.855531444551, 14936.775948361, 15173.165475898932, 15683.274839767844, 11368.261063030877, 13533.458661653818, 13892.09470565601, 14151.363188656329, 14403.0, 10669.306495077795, 13833.86166138366, 14218.217998010208, 14248.931330150488, 14389.424423022961, 13088.869111308764, 13309.134906231064, 14159.64600884986, 14188.787168192692, 14641.414343426144, 10235.385876847413, 11470.483828227583, 11513.942430287794, 11730.0, 11758.41261429696, 8787.75178126777, 10308.845367319345, 10532.736071671448, 10706.357618542912, 10924.50839712199], "value": 7776.37156810584, "unit": "score"}], "name": "dromaeo_css", "value": 7323.558458242446, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 117.0, 172.0, 115.0, 107.0, 111.0, 106.0, 139.0, 108.0], "value": 122.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 185.0, 183.0, 181.0, 185.0, 183.0, 183.0, 184.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 60.0, 87.0, 61.0, 58.0, 58.0, 60.0, 85.0, 69.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 93.0, 73.0, 68.0, 69.0, 92.0, 68.0, 68.0, 90.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 90.0, 87.0, 90.0, 88.0, 90.0, 130.0], "value": 92.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 99.0, 98.0, 97.0, 98.0, 98.0, 98.0, 96.0, 98.0], "value": 97.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 84.0, 84.0, 85.0, 86.0, 85.0, 82.0, 87.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 53.0, 55.0, 57.0, 56.0, 56.0, 56.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 72.0, 73.0, 75.0, 68.0, 69.0, 68.0, 70.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 91.0, 98.0, 85.0, 84.0, 81.0, 85.0, 83.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 140.0, 138.0, 139.0, 140.0, 143.0, 150.0, 173.0, 153.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 164.0, 164.0, 163.0, 167.0, 164.0, 163.0, 163.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1429.3, "alertThreshold": 2.0}]} 14:24:55 INFO - Return code: 0 14:24:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:24:55 INFO - # TBPL SUCCESS # 14:24:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:24:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:24:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:24:55 INFO - 2016-10-26 14:24:55.854 screenresolution[1666:9819] starting screenresolution argv=screenresolution get 14:24:55 INFO - 2016-10-26 14:24:55.857 screenresolution[1666:9819] Display 0: 1600x1200x32@60 14:24:55 INFO - 2016-10-26 14:24:55.863 screenresolution[1667:9822] starting screenresolution argv=screenresolution list 14:24:55 INFO - Available Modes on Display 0 14:24:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:24:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:24:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:24:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:24:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:24:56 INFO - Intel Iris: 14:24:56 INFO - Chipset Model: Intel Iris 14:24:56 INFO - Type: GPU 14:24:56 INFO - Bus: Built-In 14:24:56 INFO - VRAM (Dynamic, Max): 1536 MB 14:24:56 INFO - Vendor: Intel (0x8086) 14:24:56 INFO - Device ID: 0x0a2e 14:24:56 INFO - Revision ID: 0x0009 14:24:56 INFO - Displays: 14:24:56 INFO - Display: 14:24:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:24:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:24:56 INFO - Display Serial Number: 1600x1200 60 14:24:56 INFO - Main Display: Yes 14:24:56 INFO - Mirror: Off 14:24:56 INFO - Online: Yes 14:24:56 INFO - Rotation: Supported 14:24:56 INFO - Return code: 0 14:24:56 INFO - Running post-action listener: _resource_record_post_action 14:24:56 INFO - [mozharness: 2016-10-26 21:24:56.097701Z] Finished run-tests step (success) 14:24:56 INFO - Running post-run listener: _resource_record_post_run 14:24:56 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 38269952; Write bytes: 664078336; Read time: 377; Write time: 1881 14:24:56 INFO - TinderboxPrint: CPU usage
53.2% 14:24:56 INFO - TinderboxPrint: I/O read bytes / time
38,269,952 / 377 14:24:56 INFO - TinderboxPrint: I/O write bytes / time
664,078,336 / 1,881 14:24:56 INFO - TinderboxPrint: CPU idle
2,264.2 (46.8%) 14:24:56 INFO - TinderboxPrint: CPU system
964.4 (19.9%) 14:24:56 INFO - TinderboxPrint: CPU user
1,609.0 (33.3%) 14:24:56 INFO - TinderboxPrint: Swap in / out
401,711,104 / 0 14:24:56 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356581888; Write bytes: 356833280; Read time: 27466; Write time: 709 14:24:56 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36459520; Write bytes: 296255488; Read time: 358; Write time: 1137 14:24:56 INFO - Running post-run listener: _upload_blobber_files 14:24:56 INFO - Blob upload gear active. 14:24:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:24:56 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:24:56 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:24:56 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:24:56 INFO - (blobuploader) - INFO - Open directory for files ... 14:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:24:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:24:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:57 INFO - (blobuploader) - INFO - Done attempting. 14:24:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:24:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:24:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:58 INFO - (blobuploader) - INFO - Done attempting. 14:24:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:24:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:25:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:00 INFO - (blobuploader) - INFO - Done attempting. 14:25:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:25:00 INFO - Return code: 0 14:25:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:25:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:25:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3842478002e672143e369f4998fb1004e1cc96606045dabea1fca6642aed3c7595b1388e636c3b0f2bc93009d5399beac8a585a093fe26c4f5a24388ca6dd25d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1374d006345e154cb412af0401a61e69f9b66a3997f880bd8825dc08ef969381b6e0b6feb435bda0a3a19ee6df3cde030b14affff2a4846dd26e3b51c1a8d6e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1119ab9069e5f409ba418d59af87b1ac2e3a0372d1def30c28562db9b7957a9d48366448677231b9921cd6487f97170bff722d7df1181ebe9eeb79bc72cb79c"} 14:25:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:25:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:25:00 INFO - Contents: 14:25:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3842478002e672143e369f4998fb1004e1cc96606045dabea1fca6642aed3c7595b1388e636c3b0f2bc93009d5399beac8a585a093fe26c4f5a24388ca6dd25d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1374d006345e154cb412af0401a61e69f9b66a3997f880bd8825dc08ef969381b6e0b6feb435bda0a3a19ee6df3cde030b14affff2a4846dd26e3b51c1a8d6e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1119ab9069e5f409ba418d59af87b1ac2e3a0372d1def30c28562db9b7957a9d48366448677231b9921cd6487f97170bff722d7df1181ebe9eeb79bc72cb79c"} 14:25:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:25:00 INFO - Copying logs to upload dir... 14:25:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:25:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.785350 ========= master_lag: 1.87 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-26 14:25:02.727891) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:02.731867) ========= 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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3842478002e672143e369f4998fb1004e1cc96606045dabea1fca6642aed3c7595b1388e636c3b0f2bc93009d5399beac8a585a093fe26c4f5a24388ca6dd25d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1374d006345e154cb412af0401a61e69f9b66a3997f880bd8825dc08ef969381b6e0b6feb435bda0a3a19ee6df3cde030b14affff2a4846dd26e3b51c1a8d6e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1119ab9069e5f409ba418d59af87b1ac2e3a0372d1def30c28562db9b7957a9d48366448677231b9921cd6487f97170bff722d7df1181ebe9eeb79bc72cb79c"} 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.010944 build_url: 'https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3842478002e672143e369f4998fb1004e1cc96606045dabea1fca6642aed3c7595b1388e636c3b0f2bc93009d5399beac8a585a093fe26c4f5a24388ca6dd25d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1374d006345e154cb412af0401a61e69f9b66a3997f880bd8825dc08ef969381b6e0b6feb435bda0a3a19ee6df3cde030b14affff2a4846dd26e3b51c1a8d6e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e1119ab9069e5f409ba418d59af87b1ac2e3a0372d1def30c28562db9b7957a9d48366448677231b9921cd6487f97170bff722d7df1181ebe9eeb79bc72cb79c"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:02.807316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:02.807799) ========= 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.lYIYGjKtx9/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.nFO9CYDjP2/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005230 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:02.833111) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:25:02.833451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:25:02.833788) ========= ========= Total master_lag: 2.02 =========