builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0326 starttime: 1477515851.72 results: success (0) buildid: 20161026004014 builduid: 0ff6334abedd49bb95ab30a9518c83be revision: a16ab27e533088e1711a82ff380d3ebd262ca837 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:11.721237) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:11.721673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:11.721958) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:11.746926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:11.747307) ========= 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.vViDGvUUBI/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.CDOuURhEq8/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-26 14:04:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2016-10-26 14:04:11 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:11.888021) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:11.888417) ========= 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.vViDGvUUBI/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.CDOuURhEq8/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.026175 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:11.937159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 14:04:11.937530) ========= 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.vViDGvUUBI/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.CDOuURhEq8/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-26 14:04:12,018 truncating revision to first 12 chars 2016-10-26 14:04:12,018 Setting DEBUG logging. 2016-10-26 14:04:12,018 attempt 1/10 2016-10-26 14:04:12,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a16ab27e5330?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 14:04:12,761 unpacking tar archive at: mozilla-aurora-a16ab27e5330/testing/mozharness/ program finished with exit code 0 elapsedTime=1.010611 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 14:04:12.969724) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:12.970049) ========= script_repo_revision: a16ab27e533088e1711a82ff380d3ebd262ca837 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:12.970443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:12.970706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 14:04:12.988899) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-26 14:04:12.989301) ========= /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.vViDGvUUBI/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.CDOuURhEq8/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:04:13 INFO - MultiFileLogger online at 20161026 14:04:13 in /builds/slave/test 14:04:13 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:04:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:04:13 INFO - {'append_to_log': False, 14:04:13 INFO - 'base_work_dir': '/builds/slave/test', 14:04:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:04:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:04:13 INFO - 'branch': 'Mozilla-Aurora', 14:04:13 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:13 INFO - 'config_files': ('talos/mac_config.py',), 14:04:13 INFO - 'default_actions': ('clobber', 14:04:13 INFO - 'read-buildbot-config', 14:04:13 INFO - 'download-and-extract', 14:04:13 INFO - 'populate-webroot', 14:04:13 INFO - 'create-virtualenv', 14:04:13 INFO - 'install', 14:04:13 INFO - 'run-tests'), 14:04:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:13 INFO - 'download_minidump_stackwalk': True, 14:04:13 INFO - 'download_symbols': 'ondemand', 14:04:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:13 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:13 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:13 INFO - 'installer_path': 'installer.exe', 14:04:13 INFO - 'log_level': 'info', 14:04:13 INFO - 'log_name': 'talos', 14:04:13 INFO - 'log_to_console': True, 14:04:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:04:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:04:13 INFO - 'opt_config_files': (), 14:04:13 INFO - 'pip_index': False, 14:04:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:04:13 INFO - 'cmd': ('bash', 14:04:13 INFO - '-c', 14:04:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:04:13 INFO - 'enabled': True, 14:04:13 INFO - 'halt_on_failure': False, 14:04:13 INFO - 'name': 'check_screen_resolution'},), 14:04:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:04:13 INFO - 'cmd': ('bash', 14:04:13 INFO - '-c', 14:04:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:04:13 INFO - 'enabled': True, 14:04:13 INFO - 'halt_on_failure': False, 14:04:13 INFO - 'name': 'check_screen_resolution'},), 14:04:13 INFO - 'run_cmd_checks_enabled': True, 14:04:13 INFO - 'sps_profile': False, 14:04:13 INFO - 'sps_profile_interval': 0, 14:04:13 INFO - 'suite': 'dromaeojs', 14:04:13 INFO - 'system_bits': '32', 14:04:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:13 INFO - 'title': 't-yosemite-r7-0326', 14:04:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:13 INFO - 'use_talos_json': True, 14:04:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:04:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:13 INFO - 'work_dir': 'build'} 14:04:13 INFO - [mozharness: 2016-10-26 21:04:13.186430Z] Running clobber step. 14:04:13 INFO - Running pre-action listener: _resource_record_pre_action 14:04:13 INFO - Running main action method: clobber 14:04:13 INFO - rmtree: /builds/slave/test/build 14:04:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:04:15 INFO - Running post-action listener: _resource_record_post_action 14:04:15 INFO - [mozharness: 2016-10-26 21:04:15.228085Z] Finished clobber step (success) 14:04:15 INFO - [mozharness: 2016-10-26 21:04:15.228238Z] Running read-buildbot-config step. 14:04:15 INFO - Running pre-action listener: _resource_record_pre_action 14:04:15 INFO - Running main action method: read_buildbot_config 14:04:15 INFO - Using buildbot properties: 14:04:15 INFO - { 14:04:15 INFO - "project": "", 14:04:15 INFO - "product": "firefox", 14:04:15 INFO - "script_repo_revision": "production", 14:04:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 14:04:15 INFO - "repository": "", 14:04:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 14:04:15 INFO - "buildid": "20161026004014", 14:04:15 INFO - "stage_platform": "macosx64", 14:04:15 INFO - "basedir": "/builds/slave/test", 14:04:15 INFO - "nightly_build": "True", 14:04:15 INFO - "buildnumber": 68, 14:04:15 INFO - "slavename": "t-yosemite-r7-0326", 14:04:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:04:15 INFO - "platform": "yosemite_r7", 14:04:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:04:15 INFO - "branch": "mozilla-aurora", 14:04:15 INFO - "repo_path": "releases/mozilla-aurora", 14:04:15 INFO - "revision": "a16ab27e533088e1711a82ff380d3ebd262ca837", 14:04:15 INFO - "pgo_build": "False", 14:04:15 INFO - "builduid": "0ff6334abedd49bb95ab30a9518c83be", 14:04:15 INFO - "slavebuilddir": "test" 14:04:15 INFO - } 14:04:15 INFO - Found installer 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 - [mozharness: 2016-10-26 21:04:15.231704Z] Finished read-buildbot-config step (success) 14:04:15 INFO - [mozharness: 2016-10-26 21:04:15.231836Z] Running download-and-extract step. 14:04:15 INFO - Running pre-action listener: _resource_record_pre_action 14:04:15 INFO - Running main action method: download_and_extract 14:04:15 INFO - mkdir: /builds/slave/test/build/tests 14:04:15 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:15 INFO - trying https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 14:04:15 INFO - Downloading https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 14:04:15 INFO - Downloaded 1199 bytes. 14:04:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 14:04:15 INFO - Using the following test package requirements: 14:04:15 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:04:15 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:15 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 14:04:15 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:15 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 14:04:15 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:15 INFO - u'jsshell-mac.zip'], 14:04:15 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:15 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 14:04:15 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 14:04:15 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:15 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 14:04:15 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:15 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 14:04:15 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:15 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 14:04:15 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 14:04:15 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 14:04:15 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:04:15 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:15 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:15 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:16 INFO - Expected file size: 16420194 14:04:23 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:23 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:23 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:23 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:23 INFO - Expected file size: 16420194 14:04:30 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:30 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:30 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:30 INFO - Expected file size: 14414081 14:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:31 INFO - trying https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:04:31 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:31 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:34 INFO - Downloaded 115527563 bytes. 14:04:34 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:34 INFO - mkdir: /builds/slave/test/properties 14:04:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:04:34 INFO - Writing to file /builds/slave/test/properties/build_url 14:04:34 INFO - Contents: 14:04:34 INFO - build_url:https://queue.taskcluster.net/v1/task/boVIKEnRSt2TMca33aEl_Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 14:04:35 INFO - Running post-action listener: _resource_record_post_action 14:04:35 INFO - Running post-action listener: set_extra_try_arguments 14:04:35 INFO - [mozharness: 2016-10-26 21:04:35.170062Z] Finished download-and-extract step (success) 14:04:35 INFO - [mozharness: 2016-10-26 21:04:35.170196Z] Running populate-webroot step. 14:04:35 INFO - Running pre-action listener: _resource_record_pre_action 14:04:35 INFO - Running main action method: populate_webroot 14:04:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:04:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:04:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:04:35 INFO - '--tppagecycles', 14:04:35 INFO - '7'], 14:04:35 INFO - 'tests': ['tsvgm']}}, 14:04:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:04:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:04:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:04:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:04:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['damp', 'tps']}, 14:04:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'tests': ['damp', 'tps']}, 14:04:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['dromaeo_dom']}, 14:04:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:04:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['basic_compositor_video']}, 14:04:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:04:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore', 14:04:35 INFO - 'tabpaint']}, 14:04:35 INFO - 'other-e10s': {'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore', 14:04:35 INFO - 'tabpaint']}, 14:04:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore', 14:04:35 INFO - 'tabpaint']}, 14:04:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore', 14:04:35 INFO - 'tabpaint']}, 14:04:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore', 14:04:35 INFO - 'tabpaint']}, 14:04:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore', 14:04:35 INFO - 'tabpaint']}, 14:04:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['tsvgx', 14:04:35 INFO - 'tsvgr_opacity', 14:04:35 INFO - 'tart', 14:04:35 INFO - 'tscrollx', 14:04:35 INFO - 'cart']}, 14:04:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:04:35 INFO - 'tsvgr_opacity', 14:04:35 INFO - 'tart', 14:04:35 INFO - 'tscrollx', 14:04:35 INFO - 'cart']}, 14:04:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'talos_options': ['--disable-e10s'], 14:04:35 INFO - 'tests': ['tp5o']}, 14:04:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'tests': ['tp5o']}, 14:04:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'talos_options': ['--disable-e10s', 14:04:35 INFO - '--xperf_path', 14:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:35 INFO - 'tests': ['tp5n']}, 14:04:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'talos_options': ['--xperf_path', 14:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:35 INFO - 'tests': ['tp5n']}}, 14:04:35 INFO - 'talos.zip': {'path': '', 14:04:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:04:35 INFO - Running post-action listener: _resource_record_post_action 14:04:35 INFO - [mozharness: 2016-10-26 21:04:35.188912Z] Finished populate-webroot step (success) 14:04:35 INFO - [mozharness: 2016-10-26 21:04:35.189037Z] Running create-virtualenv step. 14:04:35 INFO - Running pre-action listener: _resource_record_pre_action 14:04:35 INFO - Running main action method: create_virtualenv 14:04:35 INFO - Creating virtualenv /builds/slave/test/build/venv 14:04:35 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:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:04:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:04:35 INFO - Using real prefix '/tools/python27' 14:04:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:04:36 INFO - Installing distribute.............................................................................................................................................................................................done. 14:04:38 INFO - Installing pip.................done. 14:04:38 INFO - Return code: 0 14:04:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:04:38 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:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:38 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:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:38 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 0x108a53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0bd5d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, '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.vViDGvUUBI/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.CDOuURhEq8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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:38 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:38 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:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/Render', 14:04:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:38 INFO - 'HOME': '/Users/cltbld', 14:04:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:38 INFO - 'LOGNAME': 'cltbld', 14:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:38 INFO - 'MOZ_NO_REMOTE': '1', 14:04:38 INFO - 'NO_EM_RESTART': '1', 14:04:38 INFO - 'PAGER': '/bin/cat', 14:04:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:38 INFO - 'PWD': '/builds/slave/test', 14:04:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:38 INFO - 'SHELL': '/bin/bash', 14:04:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDOuURhEq8/Listeners', 14:04:38 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 14:04:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:38 INFO - 'USER': 'cltbld', 14:04:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:38 INFO - 'XPC_FLAGS': '0x0', 14:04:38 INFO - 'XPC_SERVICE_NAME': '0', 14:04:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:39 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:39 INFO - Cleaning up... 14:04:39 INFO - Return code: 0 14:04:39 INFO - Installing psutil>=3.1.1 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', '--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 0x108a53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0bd5d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, '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.vViDGvUUBI/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.CDOuURhEq8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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', '--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:39 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:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/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.CDOuURhEq8/Listeners', 14:04:39 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:39 INFO - Downloading/unpacking psutil>=3.1.1 14:04:39 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:39 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:39 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:39 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:39 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:39 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:42 INFO - Installing collected packages: psutil 14:04:42 INFO - Running setup.py install for psutil 14:04:42 INFO - building 'psutil._psutil_osx' extension 14:04:42 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:43 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:43 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:43 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:43 INFO - building 'psutil._psutil_posix' extension 14:04:43 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:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:04:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:04:43 INFO - ^ 14:04:43 INFO - 1 warning generated. 14:04:43 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:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:43 INFO - Successfully installed psutil 14:04:43 INFO - Cleaning up... 14:04:43 INFO - Return code: 0 14:04:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:43 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 0x108a53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0bd5d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, '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.vViDGvUUBI/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.CDOuURhEq8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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:43 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:43 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:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/Render', 14:04:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:43 INFO - 'HOME': '/Users/cltbld', 14:04:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:43 INFO - 'LOGNAME': 'cltbld', 14:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:43 INFO - 'MOZ_NO_REMOTE': '1', 14:04:43 INFO - 'NO_EM_RESTART': '1', 14:04:43 INFO - 'PAGER': '/bin/cat', 14:04:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:43 INFO - 'PWD': '/builds/slave/test', 14:04:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:43 INFO - 'SHELL': '/bin/bash', 14:04:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDOuURhEq8/Listeners', 14:04:43 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 14:04:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:43 INFO - 'USER': 'cltbld', 14:04:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:43 INFO - 'XPC_FLAGS': '0x0', 14:04:43 INFO - 'XPC_SERVICE_NAME': '0', 14:04:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:04:43 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:43 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:43 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:43 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:43 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:43 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:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:04:46 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:46 INFO - Installing collected packages: mozsystemmonitor 14:04:46 INFO - Running setup.py install for mozsystemmonitor 14:04:46 INFO - Successfully installed mozsystemmonitor 14:04:46 INFO - Cleaning up... 14:04:46 INFO - Return code: 0 14:04:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0bd5d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, '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.vViDGvUUBI/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.CDOuURhEq8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:04:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/Render', 14:04:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:46 INFO - 'HOME': '/Users/cltbld', 14:04:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:46 INFO - 'LOGNAME': 'cltbld', 14:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:46 INFO - 'MOZ_NO_REMOTE': '1', 14:04:46 INFO - 'NO_EM_RESTART': '1', 14:04:46 INFO - 'PAGER': '/bin/cat', 14:04:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:46 INFO - 'PWD': '/builds/slave/test', 14:04:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:46 INFO - 'SHELL': '/bin/bash', 14:04:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDOuURhEq8/Listeners', 14:04:46 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 14:04:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:46 INFO - 'USER': 'cltbld', 14:04:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:46 INFO - 'XPC_FLAGS': '0x0', 14:04:46 INFO - 'XPC_SERVICE_NAME': '0', 14:04:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:46 INFO - Downloading/unpacking jsonschema==2.5.1 14:04:46 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:46 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:46 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:46 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:46 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:46 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:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:04:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:04:49 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:49 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:49 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:49 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:49 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:49 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:49 INFO - Downloading functools32-3.2.3-2.tar.gz 14:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:04:49 INFO - warning: no files found matching '*.txt' 14:04:49 INFO - no previously-included directories found matching 'build' 14:04:49 INFO - no previously-included directories found matching 'dist' 14:04:49 INFO - no previously-included directories found matching '.git*' 14:04:49 INFO - Installing collected packages: jsonschema, functools32 14:04:50 INFO - Running setup.py install for functools32 14:04:50 INFO - warning: no files found matching '*.txt' 14:04:50 INFO - no previously-included directories found matching 'build' 14:04:50 INFO - no previously-included directories found matching 'dist' 14:04:50 INFO - no previously-included directories found matching '.git*' 14:04:50 INFO - Successfully installed jsonschema functools32 14:04:50 INFO - Cleaning up... 14:04:50 INFO - Return code: 0 14:04:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:04:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:50 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 0x108a53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0bd5d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, '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.vViDGvUUBI/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.CDOuURhEq8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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:50 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:50 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:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/Render', 14:04:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:50 INFO - 'HOME': '/Users/cltbld', 14:04:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:50 INFO - 'LOGNAME': 'cltbld', 14:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:50 INFO - 'MOZ_NO_REMOTE': '1', 14:04:50 INFO - 'NO_EM_RESTART': '1', 14:04:50 INFO - 'PAGER': '/bin/cat', 14:04:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:50 INFO - 'PWD': '/builds/slave/test', 14:04:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:50 INFO - 'SHELL': '/bin/bash', 14:04:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDOuURhEq8/Listeners', 14:04:50 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 14:04:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:50 INFO - 'USER': 'cltbld', 14:04:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:50 INFO - 'XPC_FLAGS': '0x0', 14:04:50 INFO - 'XPC_SERVICE_NAME': '0', 14:04:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:04:50 INFO - Cleaning up... 14:04:50 INFO - Return code: 0 14:04:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:04:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:50 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 0x108a53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0bd5d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, '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.vViDGvUUBI/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.CDOuURhEq8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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:50 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:50 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:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/Render', 14:04:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:50 INFO - 'HOME': '/Users/cltbld', 14:04:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:50 INFO - 'LOGNAME': 'cltbld', 14:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:50 INFO - 'MOZ_NO_REMOTE': '1', 14:04:50 INFO - 'NO_EM_RESTART': '1', 14:04:50 INFO - 'PAGER': '/bin/cat', 14:04:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:50 INFO - 'PWD': '/builds/slave/test', 14:04:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:50 INFO - 'SHELL': '/bin/bash', 14:04:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDOuURhEq8/Listeners', 14:04:50 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 14:04:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:50 INFO - 'USER': 'cltbld', 14:04:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:50 INFO - 'XPC_FLAGS': '0x0', 14:04:50 INFO - 'XPC_SERVICE_NAME': '0', 14:04:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:50 INFO - Downloading/unpacking blobuploader==1.2.4 14:04:50 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:50 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:50 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:50 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:50 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:50 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:53 INFO - Downloading blobuploader-1.2.4.tar.gz 14:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:04:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:04:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:04:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:04:54 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:54 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:54 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:54 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:54 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:54 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:54 INFO - Downloading docopt-0.6.1.tar.gz 14:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:04:54 INFO - Installing collected packages: blobuploader, requests, docopt 14:04:54 INFO - Running setup.py install for blobuploader 14:04:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:04:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:04:54 INFO - Running setup.py install for requests 14:04:55 INFO - Running setup.py install for docopt 14:04:55 INFO - Successfully installed blobuploader requests docopt 14:04:55 INFO - Cleaning up... 14:04:55 INFO - Return code: 0 14:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:04:55 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:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:55 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:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:55 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 0x108a53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0bd5d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, '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.vViDGvUUBI/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.CDOuURhEq8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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:55 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:55 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:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/Render', 14:04:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:04:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:04:55 INFO - 'HOME': '/Users/cltbld', 14:04:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:04:55 INFO - 'LOGNAME': 'cltbld', 14:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:55 INFO - 'MOZ_NO_REMOTE': '1', 14:04:55 INFO - 'NO_EM_RESTART': '1', 14:04:55 INFO - 'PAGER': '/bin/cat', 14:04:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:04:55 INFO - 'PWD': '/builds/slave/test', 14:04:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:04:55 INFO - 'SHELL': '/bin/bash', 14:04:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDOuURhEq8/Listeners', 14:04:55 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 14:04:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:04:55 INFO - 'USER': 'cltbld', 14:04:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:04:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:55 INFO - 'XPC_FLAGS': '0x0', 14:04:55 INFO - 'XPC_SERVICE_NAME': '0', 14:04:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:04:55 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-permTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:04:55 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-AifSeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:04:55 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-kvdFTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:04:56 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-VzJHbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:04:56 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-YKbZZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:04:56 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-dYNLbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:04:56 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-ghLQwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:04:56 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-g3jUcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:04:56 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-f2gsmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:04:56 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-2VLZFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:04:56 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-h5ErBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:04:56 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-3XxKnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:04:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:04:56 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-u6FNds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:04:57 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-J31U0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:57 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-twp6tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:04:57 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-2G04yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:04:57 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-ufYfGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:04:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:04:57 INFO - Running setup.py install for manifestparser 14:04:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:04:57 INFO - Running setup.py install for mozcrash 14:04:57 INFO - Running setup.py install for mozdebug 14:04:57 INFO - Running setup.py install for mozdevice 14:04:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:04:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:04:58 INFO - Running setup.py install for mozfile 14:04:58 INFO - Running setup.py install for mozhttpd 14:04:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:04:58 INFO - Running setup.py install for mozinfo 14:04:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:04:58 INFO - Running setup.py install for mozInstall 14:04:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:04:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:04:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:04:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:04:58 INFO - Running setup.py install for mozleak 14:04:58 INFO - Running setup.py install for mozlog 14:04:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:04:58 INFO - Running setup.py install for moznetwork 14:04:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:04:59 INFO - Running setup.py install for mozprocess 14:04:59 INFO - Running setup.py install for mozprofile 14:04:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:04:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:04:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:04:59 INFO - Running setup.py install for mozrunner 14:04:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:04:59 INFO - Running setup.py install for mozscreenshot 14:04:59 INFO - Running setup.py install for moztest 14:04:59 INFO - Running setup.py install for mozversion 14:05:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:05:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:05:00 INFO - Cleaning up... 14:05:00 INFO - Return code: 0 14:05:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:00 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 0x108a53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0bd5d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, '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.vViDGvUUBI/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.CDOuURhEq8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:05:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:05:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/Render', 14:05:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:00 INFO - 'HOME': '/Users/cltbld', 14:05:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:00 INFO - 'LOGNAME': 'cltbld', 14:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:00 INFO - 'MOZ_NO_REMOTE': '1', 14:05:00 INFO - 'NO_EM_RESTART': '1', 14:05:00 INFO - 'PAGER': '/bin/cat', 14:05:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:00 INFO - 'PWD': '/builds/slave/test', 14:05:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:00 INFO - 'SHELL': '/bin/bash', 14:05:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDOuURhEq8/Listeners', 14:05:00 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 14:05:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:00 INFO - 'USER': 'cltbld', 14:05:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:00 INFO - 'XPC_FLAGS': '0x0', 14:05:00 INFO - 'XPC_SERVICE_NAME': '0', 14:05:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:00 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-KjoTex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:00 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-txxtVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:00 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Jv4H5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:00 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-kj3tQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:00 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-luu1fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:00 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-lRqS9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:00 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Q9nKIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:01 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-QBnV04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:01 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-wCqrdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:01 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Yqa3Lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:01 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-dC11Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:01 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-FiY5yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:01 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-PxI6oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:01 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-DG_BVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:01 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-k8qsIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:01 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-rvCm_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:02 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Quu4xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:04 INFO - Downloading blessings-1.6.tar.gz 14:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:05:04 INFO - Installing collected packages: blessings 14:05:04 INFO - Running setup.py install for blessings 14:05:04 INFO - Successfully installed blessings 14:05:04 INFO - Cleaning up... 14:05:05 INFO - Return code: 0 14:05:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:05:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:05 INFO - Reading from file tmpfile_stdout 14:05:05 INFO - Current package versions: 14:05:05 INFO - blessings == 1.6 14:05:05 INFO - blobuploader == 1.2.4 14:05:05 INFO - docopt == 0.6.1 14:05:05 INFO - functools32 == 3.2.3-2 14:05:05 INFO - jsonschema == 2.5.1 14:05:05 INFO - manifestparser == 1.1 14:05:05 INFO - mozInstall == 1.12 14:05:05 INFO - mozcrash == 0.17 14:05:05 INFO - mozdebug == 0.1 14:05:05 INFO - mozdevice == 0.48 14:05:05 INFO - mozfile == 1.2 14:05:05 INFO - mozhttpd == 0.7 14:05:05 INFO - mozinfo == 0.9 14:05:05 INFO - mozleak == 0.1 14:05:05 INFO - mozlog == 3.4 14:05:05 INFO - moznetwork == 0.27 14:05:05 INFO - mozprocess == 0.23 14:05:05 INFO - mozprofile == 0.28 14:05:05 INFO - mozrunner == 6.12 14:05:05 INFO - mozscreenshot == 0.1 14:05:05 INFO - mozsystemmonitor == 0.3 14:05:05 INFO - moztest == 0.7 14:05:05 INFO - mozversion == 1.4 14:05:05 INFO - psutil == 3.1.1 14:05:05 INFO - requests == 1.2.3 14:05:05 INFO - wsgiref == 0.1.2 14:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05:05 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:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:05 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:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:05 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 0x108a53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0bd5d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, '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.vViDGvUUBI/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.CDOuURhEq8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:05:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/Render', 14:05:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:05 INFO - 'HOME': '/Users/cltbld', 14:05:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:05 INFO - 'LOGNAME': 'cltbld', 14:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:05 INFO - 'MOZ_NO_REMOTE': '1', 14:05:05 INFO - 'NO_EM_RESTART': '1', 14:05:05 INFO - 'PAGER': '/bin/cat', 14:05:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:05 INFO - 'PWD': '/builds/slave/test', 14:05:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:05 INFO - 'SHELL': '/bin/bash', 14:05:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDOuURhEq8/Listeners', 14:05:05 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 14:05:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:05 INFO - 'USER': 'cltbld', 14:05:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:05 INFO - 'XPC_FLAGS': '0x0', 14:05:05 INFO - 'XPC_SERVICE_NAME': '0', 14:05:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:05:05 INFO - Cleaning up... 14:05:05 INFO - Return code: 0 14:05:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:05:05 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:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:05 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:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:05 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 0x108a53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089c9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c0bd5d170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, '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.vViDGvUUBI/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.CDOuURhEq8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:05:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/Render', 14:05:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:05 INFO - 'HOME': '/Users/cltbld', 14:05:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:05 INFO - 'LOGNAME': 'cltbld', 14:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:05 INFO - 'MOZ_NO_REMOTE': '1', 14:05:05 INFO - 'NO_EM_RESTART': '1', 14:05:05 INFO - 'PAGER': '/bin/cat', 14:05:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:05 INFO - 'PWD': '/builds/slave/test', 14:05:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:05 INFO - 'SHELL': '/bin/bash', 14:05:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDOuURhEq8/Listeners', 14:05:05 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 14:05:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:05 INFO - 'USER': 'cltbld', 14:05:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:05 INFO - 'XPC_FLAGS': '0x0', 14:05:05 INFO - 'XPC_SERVICE_NAME': '0', 14:05:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:05:05 INFO - Cleaning up... 14:05:05 INFO - Return code: 0 14:05:05 INFO - Running post-action listener: _resource_record_post_action 14:05:05 INFO - Running post-action listener: _start_resource_monitoring 14:05:05 INFO - Starting resource monitoring. 14:05:05 INFO - [mozharness: 2016-10-26 21:05:05.895251Z] Finished create-virtualenv step (success) 14:05:05 INFO - [mozharness: 2016-10-26 21:05:05.896210Z] Running install step. 14:05:05 INFO - Running pre-action listener: _resource_record_pre_action 14:05:05 INFO - Running main action method: install 14:05:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:06 INFO - Reading from file tmpfile_stdout 14:05:06 INFO - Detecting whether we're running mozinstall >=1.0... 14:05:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:05:06 INFO - Reading from file tmpfile_stdout 14:05:06 INFO - Output received: 14:05:06 INFO - Usage: mozinstall [options] installer 14:05:06 INFO - Options: 14:05:06 INFO - -h, --help show this help message and exit 14:05:06 INFO - -d DEST, --destination=DEST 14:05:06 INFO - Directory to install application into. [default: 14:05:06 INFO - "/builds/slave/test"] 14:05:06 INFO - --app=APP Application being installed. [default: firefox] 14:05:06 INFO - mkdir: /builds/slave/test/build/application 14:05:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:05:06 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:38 INFO - Reading from file tmpfile_stdout 14:05:38 INFO - Output received: 14:05:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:05:38 INFO - Running post-action listener: _resource_record_post_action 14:05:38 INFO - [mozharness: 2016-10-26 21:05:38.579680Z] Finished install step (success) 14:05:38 INFO - [mozharness: 2016-10-26 21:05:38.579830Z] Running run-tests step. 14:05:38 INFO - Running pre-action listener: _resource_record_pre_action 14:05:38 INFO - Running main action method: run_tests 14:05:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:05:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:05:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:05:38 INFO - 2016-10-26 14:05:38.594 screenresolution[1640:7518] starting screenresolution argv=screenresolution get 14:05:38 INFO - 2016-10-26 14:05:38.597 screenresolution[1640:7518] Display 0: 1600x1200x32@60 14:05:38 INFO - 2016-10-26 14:05:38.603 screenresolution[1641:7520] starting screenresolution argv=screenresolution list 14:05:38 INFO - Available Modes on Display 0 14:05:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:05:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:05:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:05:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:05:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:05:38 INFO - Intel Iris: 14:05:38 INFO - Chipset Model: Intel Iris 14:05:38 INFO - Type: GPU 14:05:38 INFO - Bus: Built-In 14:05:38 INFO - VRAM (Dynamic, Max): 1536 MB 14:05:38 INFO - Vendor: Intel (0x8086) 14:05:38 INFO - Device ID: 0x0a2e 14:05:38 INFO - Revision ID: 0x0009 14:05:38 INFO - Displays: 14:05:38 INFO - Display: 14:05:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:05:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:05:38 INFO - Display Serial Number: 1600x1200 60 14:05:38 INFO - Main Display: Yes 14:05:38 INFO - Mirror: Off 14:05:38 INFO - Online: Yes 14:05:38 INFO - Rotation: Supported 14:05:38 INFO - Return code: 0 14:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:05:38 INFO - Python 2.7.3 14:05:38 INFO - Return code: 0 14:05:38 INFO - grabbing minidump binary from tooltool 14:05:38 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:38 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 0x108867d30>, '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 0x1086cddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:05:38 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:38 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:38 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:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:05:38 INFO - Return code: 0 14:05:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:05:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:05:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:05:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:05:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:05:38 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-0326', '--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:38 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-0326 --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:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vViDGvUUBI/Render', 14:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:38 INFO - 'HOME': '/Users/cltbld', 14:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:38 INFO - 'LOGNAME': 'cltbld', 14:05:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:05:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:38 INFO - 'MOZ_NO_REMOTE': '1', 14:05:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:05:38 INFO - 'NO_EM_RESTART': '1', 14:05:38 INFO - 'PAGER': '/bin/cat', 14:05:38 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:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:38 INFO - 'PWD': '/builds/slave/test', 14:05:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:38 INFO - 'SHELL': '/bin/bash', 14:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CDOuURhEq8/Listeners', 14:05:38 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 14:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:38 INFO - 'USER': 'cltbld', 14:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:38 INFO - 'XPC_FLAGS': '0x0', 14:05:38 INFO - 'XPC_SERVICE_NAME': '0', 14:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:38 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-0326', '--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:39 INFO - mozversion application_buildid: 20161026004014 14:05:39 INFO - mozversion application_changeset: a16ab27e533088e1711a82ff380d3ebd262ca837 14:05:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:05:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:05:39 INFO - mozversion application_name: Firefox 14:05:39 INFO - mozversion application_remotingname: firefox-dev 14:05:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:05:39 INFO - mozversion application_vendor: Mozilla 14:05:39 INFO - mozversion application_version: 51.0a2 14:05:39 INFO - mozversion platform_buildid: 20161026004014 14:05:39 INFO - mozversion platform_changeset: a16ab27e533088e1711a82ff380d3ebd262ca837 14:05:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:05:39 INFO - mozversion platform_version: 51.0a2 14:05:39 INFO - using testdate: 1477515939 14:05:39 INFO - actual date: 1477515939 14:05:39 INFO - starting webserver on 'localhost:49272' 14:05:39 INFO - SUITE-START | Running 2 tests 14:05:39 INFO - TEST-START | dromaeo_css 14:05:39 INFO - operating with platform_type : mac_ 14:05:39 INFO - Initialising browser for dromaeo_css test... 14:05:39 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpVurdyK/profile http://localhost:49272/getInfo.html) 14:05:41 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 14:05:41 INFO - PROCESS | 1651 | colorDepth:24 14:05:41 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 14:05:41 INFO - PROCESS | 1651 | __metrics 14:05:41 INFO - PROCESS | 1651 | 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:41 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:42 INFO - TEST-INFO | 1651: exit 0 14:05:42 INFO - Browser initialized. 14:05:42 INFO - Running cycle 1/1 for dromaeo_css test... 14:05:42 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpVurdyK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:54 INFO - PROCESS | 1654 | RSS: Main: 219734016 14:05:54 INFO - PROCESS | 1654 | 14:06:45 INFO - PROCESS | 1654 | 1477516005498 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:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 14:08:58 INFO - PROCESS | 1654 | RSS: Main: 327671808 14:08:58 INFO - PROCESS | 1654 | 14:12:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 14:12:02 INFO - PROCESS | 1654 | RSS: Main: 355176448 14:12:02 INFO - PROCESS | 1654 | 14:15:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 14:15:05 INFO - PROCESS | 1654 | RSS: Main: 332783616 14:15:05 INFO - PROCESS | 1654 | 14:18:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 14:18:07 INFO - PROCESS | 1654 | RSS: Main: 323895296 14:18:07 INFO - PROCESS | 1654 | 14:21:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 14:21:11 INFO - PROCESS | 1654 | RSS: Main: 306769920 14:21:11 INFO - PROCESS | 1654 | 14:24:14 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 14:24:15 INFO - PROCESS | 1654 | RSS: Main: 387895296 14:24:15 INFO - PROCESS | 1654 | 14:24:15 INFO - PROCESS | 1654 | __start_tp_report 14:24:15 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 14:24:15 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 14:24:15 INFO - PROCESS | 1654 | |i|pagename|runs| 14:24:15 INFO - PROCESS | 1654 | |0;dojo.html;2819;3351.681590248927;3376.966230337696;3412.0616830371628;3416.7095796857266;5657.066584013638;5667.688277144755;5686.488216060554;5686.971565142168;5702.372738998707;5647.37878833328;5727.455891690282;5727.997600419931;5734.655920644765;5748.425157484249;5206.609504287194;5216.7391630418515;5236.450172731856;5241.9213711794355;5284.603654725892;5197.272381866523;5206.3231779868565;5208.401033881114;5295.655782374133;5301.3373328333955;4293.570642935712;5221.399539053001;5255.001549705563;5257.421683614799;5273;5226.372835259755;5237.214417837316;5276.393214780311;5287.7884884604955;5338.759755810997;5100.464451232604;5161.896762064737;5229.346331708536;5248.186531087687;5248.8425347239645;5558.527525160366;5586.35756887955;5637.577181711388;5638.323401191842;5641.097424412074;6215.06773983906;6250.937490625081;6267.2165979252595;6278.780242691484;6285.654289014103;5945.702714864239;6240.219972503437;6339.207599050119;6353.332900045475;6356.396142366514;5536.307961504772;5566.916496252559;5567.220589117527;5598.86002849932;5605.971970140124;6236.282827474898;6237.906431403532;6241.188645476059;6245.18812554365;6247.125402443661;5862.179294898718;5871.031279838779;5872.148538461985;5877.412258774174;5924.437178468039;6129.48104857405;6132.938670613326;6144.723487443076;6199.969000154971;6238.625682459067;6197.318294987548;6212.47193988507;6212.9378706213265;6214.720337584819;6226.470749986212;6097.3292937776805;6174.104754810527;6220.782272620527;6233.189685340877;6238.251409830758;4721.787519561628;4768.046390721869;4770.974240538301;4876.5854902333695;4964;4410.933835992462;4423.1153769246275;4424.358468022118;4479.216137176047;4500.077484115814;5799.420057994167;5808.303003639506;5810.50610698087;5818.2436283282905;5865.413458654186;6097.451229389376;6189;6313.116163737081;6314.842128946813;6328.272248691367;5738.340090889517;5751.166080918243;5812.970935145382;5819.214406055213;5869.941300587025;5356.651817631841;5403.594730395236;5410.78356865721;5412.621116521885;5414.431484694129;6337;6344.270408903035;6365.649889256136;6368.044793280859;6376.872462550723;6119.898632333015;6127.494965204967;6199.907001395073;6248.781292654735;6251.78118765841;6271.96864015677;6311.684415779285;6314;6334.556581039283;6334.90497642545;6156.876862462816;6179.505639548735;6185.783497577563;6191.473724733268;6204.348543402878;4917.877053073702;6119.541034422525;6145.310039739107;6179.536534760001;6240.781572644935;6042.0936859469675;6073.99779036454;6078.118672792509;6084.939150608614;6125.754969801158;4991.5258050485145;6050.21347224858;6105.267367915879;6113.449789518964;6117.357677443804;5671.602987790815;5770.653760774367;5838.416158384298;5921.3782552831335;5945.583809133319;6082.513398928164;6123.68219977123;6139.298708568215;6151.384861513813;6154.292256390572;5908.497777688945;5948.405159484017;5948.791792287422;5965.582409231312;5986.610870293417 14:24:15 INFO - PROCESS | 1654 | |1;ext.html;453.14808160657964;534.6311045378689;536.2519285596593;545.0053652084945;551.0741953518088;30874.382512349766;40708.592914070854;42079.36880946788;42136.15727685448;44261;41865.58134418655;43258.78370608151;43542;43631.78184109083;43755.562444375544;9687.370320929118;9890.90109098907;9891.604335826594;9892.950535247313;9896.455694936776;8810.074942131048;9023.503707296097;12079.879201208007;12313.876861231407;12334;12163.209391389575;12272.447739851728;12276.079294052981;12297.3236471994;12325.013998880113;8809.823803523957;12279.570215042475;12349.814752778715;12353.814692779615;12370.319632420213;8664.523451210243;8890.066543012956;8900.287976961827;8912.420692655021;11674;39292.80353598242;41543.75368738943;41639.75080747582;41724.58275417237;41808.95477613054;3328.2012317043977;3377.645347238529;3654.5797233318244;3921.156951255494;4090.7545547266964;30086.097417077523;30273.545896811567;30274.940377086918;31320.843395783104;32692;3255.8372081395837;3290.457074582691;3301.240714635623;3334.71654909333;3385.746069044807;525508;531813.363732727;532318.9999999962;534102;535625;61949.451263718765;62422.68788656028;62628.37371626226;62667.686661566404;62702;65211.347886520525;65348;65382;65424.672876636265;65549.34450655528;15644.296006679726;17088.974661520348;17112.657746844994;17121.630269578654;17148.142592870307;11803.23278986863;12115.39423028845;13121.409536570878;13189.47242110324;13223.603291901258;15229.314680839389;16710.83289167093;16991.83008169927;17192;17483.300667973137;6076.513878889678;6113.38866113394;6140;6178.814635560941;6212.9378706213265;831.8752187171973;915.6566287642135;929.6746138851348;957.5212393803098;1035.8446233065101;29199.56200656992;30116.54825177624;30166.547501787492;30300.69699302979;30936.535951960737;991.3308516751164;1033.1837848100067;1045.5451878432907;1045.7124290819934;1050.5955207245265;15627.765583516257;15747.921260393625;15807.68384632324;15868.52394428169;16089.275982580577;680502;686893;689517;690496;692196;57160.71419642958;57508;57585.42414575884;57643;57644.42355576474;1218.500414829933;1260.24385368778;1350.7973803929096;1359.8708122728326;1389.1387339849357;29996.850015750653;30742.077737667907;31960.68039319577;31996.84001579977;32598;49775.75112124416;50171.74914125406;50300.24549631685;50339.74830125826;50362;553374;553617;555532;556256;557677.6928922797;26230.4753904917;26828.59757103684;26964.865175673996;27172.592411113455;27543.449131017667;47596;47984.5201547994;48023;48537.27194092162;48608.51391486181;39082.80458597689;39479.2104157921;39671.40492892667;39795.80102099471;41408.58591414047;39568.80215598903;39767.80116099401;40040.31372862135;41191.382129267484;41354.379684305364;38226.617733822306;39451.40822887716;39620.405693914036;39736.20527589374;39744.403833941935;31075.844620776752;34665.65334346624;35278.64721352753;35559.82220088883;35873.64126358808;26132.34669133287;26260.4747905037;26269;26383.682909323034;26720.19839404821 14:24:15 INFO - PROCESS | 1654 | |2;jquery.html;328.4252558023459;354.36922278344554;376.33952413514294;385.96140385961405;404.06862182668937;14902.77645835312;14984.700305993874;16078.035317880935;20707.792922070774;21127.366179014654;19953.501162470944;20782.89608551955;20793.584128317423;21379.57240855182;21636.918154092313;4492;5724.084146536555;5970.910436343458;5972.0444728843395;5977.9837427637185;4146.66826653867;4381.583749543788;5895.764169433218;5919.230500035011;5995.760169593211;4244.851430199944;6281.842953926165;6580.111684922546;6603;6681.331866813304;6382.585131966431;6487.83780405489;6504.349565043505;6539.869202615921;6663.433608143314;5678.914816277759;5684.317881854204;5684.857878553028;5688.772449102031;5698.572607054488;24121.517569648684;24195.395115122086;24979.62530562043;25203.49593008148;25313;2160.459885028743;2210.1490925993608;2280.2817112609473;2351.729551101628;2385.3678775124604;9420;9865.358751681119;10243.231757618209;10426.68719938403;10471.738206544822;1857.2942281932778;1864.3940719266293;1870.532366908273;1924.7497825282624;1939.4084804134734;120931.32549396028;127457;129321;131428;132109.33945330212;9291.002434476484;11497.367644779617;11625.644275243352;11647;11847.940760296144;14825;14878.479253226085;14883.702325953636;14889.776653350209;14890.776638350433;8321.500709957421;8648.1784230498;8685.002449436664;8727.04002559718;8748.081451447633;8542.871856922151;8562.100979397073;8627.568621569022;8717.346199035097;8736.8689469658;3751.4619006207868;4434.955650443519;4525.434320709911;4537.705049171794;4608.170529304757;1759.4369801663345;1803.8110889384534;1894.6400183965002;1928.98071019288;1941.3011315926256;786.5162924801206;879.7316818370458;900.2527901841587;935.7941252924346;959.0888655777039;19667.803321966596;21492.892535537223;21502.89248553747;21591.78408215929;21685.67471487929;934.1639232886664;956.6556039825657;963.9084286992725;969.5443141723379;981.4454833019321;8914.73255802327;10241.795164096826;11247.83128253077;11272.830907536394;11287.98408143271;557698;580609;589708.0514597399;614971;632858;138162;139454;140338;143014;144721;970.6069042037985;977.8679878216492;991.3952488981715;993.9552720127612;994.9403035817729;18004.099795010457;18688.97210653427;19045.04774761284;19304.03479825975;19306.613867722284;48151.75924120497;52328;53731.92536149333;55642;56831.14753278621;77813.61093194498;78807.60596197212;80187;81070;81729;6909.723611055501;7104.076470058859;7269.636518173965;7294.452916031213;7398.556086634604;7173.820654483679;9568.76078098053;11668.824967625322;12211.69470763238;12595.88493807453;10101.343412678152;10475.266731329039;10962.945185274022;10985.231033827555;11238;8826.426282291888;11021.44892755343;11065.280756750786;11183.049440797624;11197.320401939774;9341;9437.480938548446;11052.171087168656;11194.384308863091;11327.830082548604;7164.749233776793;7183.317584829433;7349.154847192642;7455.440841936768;7544.0569928758905;9821.901780982098;10806.675799726021;10824.350538967687;11096;11175 14:24:15 INFO - PROCESS | 1654 | |3;mootools.html;1507.3744396075626;1510.9848901510984;1704.5056933489288;1821.4808779497846;1867.8038805925387;8554.05905350411;9134.132257435542;9141.862872056925;9160.312976526771;9167.220786233178;7891.802704932379;8167.346612271019;8184.263416292532;8701.782455438617;8869.645214191425;2048.832165665571;2381.7499162587897;2403.807695384365;2414.0947144820693;2416.806655467567;2385.2009576791797;2399.5560821248123;2423.75762423758;2424.103081859714;2425.3451568076607;2004.5990801839619;2397.5324811661735;2408.4099395648004;2417.6615273861676;2420.673209116764;2359.539889721505;2374.964375534368;2390.4740956989435;2395.3412811476983;2396.3290278721897;1696.923638436261;2056.95886082279;2061.7114303560274;2065.0500769645982;2067.503799088223;9017.36878418511;9074;9102.499362535058;9115.817683646355;9143.817123657489;5247.291615631879;5430.755615997289;5432.592555558309;5435.755391007414;5438.945610543923;3344.180675734436;3441.6042155152227;3490.493878387645;3529.8058606776617;3541.29174165168;1032.8037672842136;1040.9895901041043;1041.1930753665895;1062.617457715222;1064.473085822515;11944.820827687592;12073.93963030188;12103.334316612583;12104;12109.394530273452;4656.976715116402;4677.129148340691;4849.80600775965;4853.611711063107;4889.853304400874;8646.610902509403;10209.693709188736;10218.642347517802;10235.43705096212;10237.23220758446;5412.025835349675;5412.864678383072;5413.377461591967;5421.864453388618;5430.864228394322;3699.3711069117776;4421.049474363027;4560.794764235618;4795.784189711471;4950.4059512858685;3940.0937784309767;3976.2445135424177;4094.447249621263;4106.7125301228625;4121.031557583965;1296.4490091710986;1320.5972178485463;1325.436689406998;1329.9202047877159;1335.5525898824003;807.5679511461458;902.5081330674798;904.6562306323555;913.7350168451208;927.3647551427293;5761.942380576141;5918.112283157475;5961.135635332939;6070.089486576961;6195.628262304276;437.949635791888;446.5066101957355;455.92249317616086;457.5310306935351;457.8168732506957;3442.5524681791208;3913.178232571192;4000.139969906484;4085.55058943516;4097.651699605567;8879.378443508893;10833.133349332034;10971.177161712903;10986.780264394667;11069.280496767846;10475.161987041018;10719.142468602493;10917.781644367069;10919.617813376653;10922.781544369069;8304.211099945496;8399.37004724648;8400.705975290835;8401.747947561584;8425.789355266044;5875.794347197828;6021.458068773656;6037.305709843248;6038.882806680778;6112.8777424452155;9891.802163956825;10096.798064038825;10354.637587684394;10379.636712715019;10393.06462418386;10527.684169474622;10529;10532.736681583021;10542.631007914686;10557;7526.209747976383;7527.548347099191;7594.392448604209;7649.770506884803;7737.497062691133;8408.83182336362;8482.066972633129;8482.151784821468;8490.193431623986;8491.95754021226;7495.925040749523;7629.237076292548;7629.504082234637;7699.345555627834;7760.611969401621;7374.520656157332;7503.174650788518;7534.284242996907;7581.772546823604;7687.730929417444;6962.199347075151;7084.36240738336;7107.893381599177;7109.857802844018;7113.608751518716;4967.875803104951;5038.589633647837;5152.742362881766;5206.453322401245;5212.113940630178;4405.986623076775;5031.144705400164;5058.064258112261;5076.517730815566;5236.947630523646 14:24:15 INFO - PROCESS | 1654 | |4;prototype.html;299.29217400846994;305.5401620561054;309.17142059281133;315.1255266635087;315.7205872802569;5182.248573956784;5355.010517164717;5391.406945236021;5432.103702889023;5454.727263636817;4876.6586338956195;4915.090708218982;5263.842084737464;5284.524392804647;5335.239371007568;3548.7338449616254;3920.862949744571;4114.07900390723;4130.256553820311;4135.793210339471;3926.7840268785208;4119.649829764474;4145.461090058288;4148.854790082348;4156.771377574232;3873;3918.392649139388;3992.2414741199223;4027.7986100694993;4034.1931613677234;4003.1593365393155;4024.8126802593306;4029.49631296088;4044.757314561136;4069.552349241581;2852.6006359109742;3080.6919308069014;3101.573276292908;3188.1232661018175;3485.3203625293077;4597.574861663236;4805.879853003668;4988.7006779592975;5283.392409872876;5386.326709161355;4293.892652683677;4449.26587113126;4634.884127896829;4638.420197475316;4647.465541462708;4812.542808433193;5633.746481408347;5652.34997975234;5681.608006038547;5719.771209151629;3665.2852693724735;3794.29805485986;3895.9546238224875;3901.141748815256;3912.6478616924614;5817.534597232211;5840.883182336372;5889.028310328834;5900.940990590125;5964.343922168558;3741.1582393961685;3749.1002159482073;3750.493683352767;3754.81225938702;3773.603771603942;3775.2826962876966;3785.73499855013;3786.981065094657;3805.3530899746556;3807.333716599584;3761.4357846322723;4258.467691538558;4541.409616749801;4564.269716845289;4576.8626941191815;4906.4918583213175;4965.925511117336;5667.489925906688;5681.9431805681415;5713.114467257582;1137.761070175256;1348.4673553946136;1350.7906274527463;1351.2973653197043;1356.0846428660614;729.5403895545772;805.595298035364;817.4032955942196;824.7340332589447;837.5937670229933;3626.6581364894632;4402.974631669468;4481.865544033684;4490.348899409567;4543.522930092358;4313.923342441425;4449.1101779644205;4879.707217566957;4963.8262660806695;4981.277714731344;4826.7827947742435;5063.443021267732;5146.819861304836;5163.948360516422;5304.973475132677;2795.9440811183663;2930.369970456362;3017.698230176965;3026.4854974654363;3031.9393612127633;5300.628955973122;5331.546818520392;5486.862828429242;5493.862653433696;6002.339742628307;4960.90078198434;5266.8419947401635;5394.703291319015;5553.056430249461;6011.308699499614;5860.589758716934;6038.969805150946;6055.424734650202;6059.818205453844;6071.664233868453;4633.606143477842;5730;5850.765969361178;5898.469137777621;5915.763369465173;4609.562091601292;5837.781642975642;5859.765609375577;5868.119782032559;5871.500922421642;5660.660360378391;5863.677497737665;5878.441548052928;6127.3566275540425;6162.599431036968;3314.1217577342504;3797.943030854595;3885.5725870154824;3893.357595996629;3896.298666239991;5842.474177324061;5848.064309710426;5874.56338042233;5901.3213480450295;5938.4061593842;5544.306961629796;5692.31692196939;5720.511577463816;5757.337906140848;5765.769369225184;5651.915221271766;5663.716814159193;5671.376148623565;5676.035074037506;5731.770729170787;4632.3977882875015;4734.325106314921;5497.783796479104;5595.944040559542;5666.263385759825;5312.6546774461085;5686.9715651421475;5730.283714535683;5780.3352614448195;5781.79763708285;5140.357455318085;5317.065371625047;5621.29438619793;5635.98552260597;5647.3505546861 14:24:15 INFO - PROCESS | 1654 | |5;yui.html;691.4157536881333;707.5294928872297;766.1151370167458;768.5696010234269;810.9270165685089;13643.454261829527;13654.795178072336;15136.470223542177;16467.423640172598;16482.83517164828;14746.926265368686;14903.403863845433;14933.253337333144;14951.700965980674;14958.700825983473;658.805652332563;674.1101745695684;817.1746535998655;828.7845160258346;843.9156084391573;852.6163226548078;860.8235311761106;864.7146441674232;864.7449002544233;867.41449521573;910.6129894794719;912.3476714149382;912.4935660708304;914.008300993423;914.7301546043933;691.3639451704444;711.4521818199958;905.814308066848;907.3557773980515;909.3589019741132;648.7761722205831;660.0396423204227;667.5260564998856;669.3875104279628;669.5714742564713;14970.775438368433;15028.398864045424;15033.548993530103;15037.548873533811;15052.32264548098;13883.652908677364;14113.576592702235;14151.221682807442;14197.432102715879;14233.217173055478;11744.882551174464;11980.374130626022;12050.758984820342;12150.939245303805;12324.938375308066;4564.269716845289;4604.654650901162;4716.434027916637;4737.147313483571;4771.928421073687;97759.99999999929;100303;119294.2105868404;126912.0963185553;127726;9522.190613797904;10935.453227338601;11414.94292528532;11443.713907152222;11730.12024098179;22745.886270568542;22884.88557557235;22932.16542676582;23004;23055.88472057629;8060.03279606451;8088.029436467662;8109.067457242375;8185.590720463953;8292.792680182924;4364.912701745948;4451.488078870907;4462.843800466968;4696.882577935579;4721.95278047222;3321.352336294448;3428.5542879425516;3429.1598558352866;3432.5022871683964;3433.639467855889;605.4762630324738;612.2071916867578;624.9125122482856;626.5676683088654;631.6841579210395;549.4203615186017;595.809341010881;599.487438240307;611.8562137897591;618.11300783376;9068.957603695906;9124.49815260167;9135.908640913505;9182.17360437564;9237;616.1774031667774;621.9209671220428;627.9699606154734;641.1952998986336;641.592588706175;4220.873373798791;4459.777011149495;4519.141363140992;4545.704529205591;4557.323987013124;86444.27111457735;123581.38209309075;143325;149000;149498;127472;129595;130026;134050;136624.31687841695;110332.79334413428;111391.4430427875;111778;113325;115835;8576.271016963628;8583.613737381707;8614.052454230155;8657.39398242117;8759.080296568769;60578;60660.39339606724;60758.08862867149;61030.98757599467;62698.68650656717;73901.30441459772;92496.61255081314;92874;94763.52618236865;98426;11550.94224528872;11622.82565761531;11741.706457338634;12246.14277000637;12309.507619695112;12159.939200303941;12205.572804951784;12396.884280414806;13002.414891329723;13014.609561713163;11775.293482391084;11864;11879.58421455245;12462.127651064338;12530.812037819258;11587.362695051854;11668.358240296866;11942;11991;12557.811632825333;11794.410279486163;11826.053915686896;12171.39143042862;12275.140740148105;12327.013838893046;9703.805923881624;9879.50602469888;10206.693799186036;10217.642382516577;10365.533550990374;9950.850737239092;9980.550875210487;10011.799764004825;10042.598296068076;10109.39343639384 14:24:15 INFO - PROCESS | 1654 | __end_tp_report 14:24:15 INFO - PROCESS | 1654 | __start_cc_report 14:24:15 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1081 14:24:15 INFO - PROCESS | 1654 | __end_cc_report 14:24:15 INFO - PROCESS | 1654 | __startTimestamp1477517055251__endTimestamp 14:24:15 INFO - PROCESS | 1654 | 14:24:15 INFO - PROCESS | 1654 | ------- Summary: start ------- 14:24:15 INFO - PROCESS | 1654 | Number of tests: 6 14:24:15 INFO - PROCESS | 1654 | 14:24:15 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5710.38 Median:5872.15 stddev:655.42 (11.2%) stddev-sans-first:616.94 14:24:15 INFO - PROCESS | 1654 | Values: 2819.0 3351.7 3377.0 3412.1 3416.7 5657.1 5667.7 5686.5 5687.0 5702.4 5647.4 5727.5 5728.0 5734.7 5748.4 5206.6 5216.7 5236.5 5241.9 5284.6 5197.3 5206.3 5208.4 5295.7 5301.3 4293.6 5221.4 5255.0 5257.4 5273.0 5226.4 5237.2 5276.4 5287.8 5338.8 5100.5 5161.9 5229.3 5248.2 5248.8 5558.5 5586.4 5637.6 5638.3 5641.1 6215.1 6250.9 6267.2 6278.8 6285.7 5945.7 6240.2 6339.2 6353.3 6356.4 5536.3 5566.9 5567.2 5598.9 5606.0 6236.3 6237.9 6241.2 6245.2 6247.1 5862.2 5871.0 5872.1 5877.4 5924.4 6129.5 6132.9 6144.7 6200.0 6238.6 6197.3 6212.5 6212.9 6214.7 6226.5 6097.3 6174.1 6220.8 6233.2 6238.3 4721.8 4768.0 4771.0 4876.6 4964.0 4410.9 4423.1 4424.4 4479.2 4500.1 5799.4 5808.3 5810.5 5818.2 5865.4 6097.5 6189.0 6313.1 6314.8 6328.3 5738.3 5751.2 5813.0 5819.2 5869.9 5356.7 5403.6 5410.8 5412.6 5414.4 6337.0 6344.3 6365.6 6368.0 6376.9 6119.9 6127.5 6199.9 6248.8 6251.8 6272.0 6311.7 6314.0 6334.6 6334.9 6156.9 6179.5 6185.8 6191.5 6204.3 4917.9 6119.5 6145.3 6179.5 6240.8 6042.1 6074.0 6078.1 6084.9 6125.8 4991.5 6050.2 6105.3 6113.4 6117.4 5671.6 5770.7 5838.4 5921.4 5945.6 6082.5 6123.7 6139.3 6151.4 6154.3 5908.5 5948.4 5948.8 5965.6 5986.6 14:24:15 INFO - PROCESS | 1654 | 14:24:15 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:72673.40 Median:39703.81 stddev:159237.57 (401.1%) stddev-sans-first:159591.95 14:24:15 INFO - PROCESS | 1654 | Values: 453.1 534.6 536.3 545.0 551.1 30874.4 40708.6 42079.4 42136.2 44261.0 41865.6 43258.8 43542.0 43631.8 43755.6 9687.4 9890.9 9891.6 9893.0 9896.5 8810.1 9023.5 12079.9 12313.9 12334.0 12163.2 12272.4 12276.1 12297.3 12325.0 8809.8 12279.6 12349.8 12353.8 12370.3 8664.5 8890.1 8900.3 8912.4 11674.0 39292.8 41543.8 41639.8 41724.6 41809.0 3328.2 3377.6 3654.6 3921.2 4090.8 30086.1 30273.5 30274.9 31320.8 32692.0 3255.8 3290.5 3301.2 3334.7 3385.7 525508.0 531813.4 532319.0 534102.0 535625.0 61949.5 62422.7 62628.4 62667.7 62702.0 65211.3 65348.0 65382.0 65424.7 65549.3 15644.3 17089.0 17112.7 17121.6 17148.1 11803.2 12115.4 13121.4 13189.5 13223.6 15229.3 16710.8 16991.8 17192.0 17483.3 6076.5 6113.4 6140.0 6178.8 6212.9 831.9 915.7 929.7 957.5 1035.8 29199.6 30116.5 30166.5 30300.7 30936.5 991.3 1033.2 1045.5 1045.7 1050.6 15627.8 15747.9 15807.7 15868.5 16089.3 680502.0 686893.0 689517.0 690496.0 692196.0 57160.7 57508.0 57585.4 57643.0 57644.4 1218.5 1260.2 1350.8 1359.9 1389.1 29996.9 30742.1 31960.7 31996.8 32598.0 49775.8 50171.7 50300.2 50339.7 50362.0 553374.0 553617.0 555532.0 556256.0 557677.7 26230.5 26828.6 26964.9 27172.6 27543.4 47596.0 47984.5 48023.0 48537.3 48608.5 39082.8 39479.2 39671.4 39795.8 41408.6 39568.8 39767.8 40040.3 41191.4 41354.4 38226.6 39451.4 39620.4 39736.2 39744.4 31075.8 34665.7 35278.6 35559.8 35873.6 26132.3 26260.5 26269.0 26383.7 26720.2 14:24:15 INFO - PROCESS | 1654 | 14:24:15 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:35436.05 Median:2275.37 stddev:100155.71 (4401.7%) stddev-sans-first:100401.98 14:24:15 INFO - PROCESS | 1654 | Values: 328.4 354.4 376.3 386.0 404.1 14902.8 14984.7 16078.0 20707.8 21127.4 19953.5 20782.9 20793.6 21379.6 21636.9 4492.0 5724.1 5970.9 5972.0 5978.0 4146.7 4381.6 5895.8 5919.2 5995.8 4244.9 6281.8 6580.1 6603.0 6681.3 6382.6 6487.8 6504.3 6539.9 6663.4 5678.9 5684.3 5684.9 5688.8 5698.6 24121.5 24195.4 24979.6 25203.5 25313.0 2160.5 2210.1 2280.3 2351.7 2385.4 9420.0 9865.4 10243.2 10426.7 10471.7 1857.3 1864.4 1870.5 1924.7 1939.4 120931.3 127457.0 129321.0 131428.0 132109.3 9291.0 11497.4 11625.6 11647.0 11847.9 14825.0 14878.5 14883.7 14889.8 14890.8 8321.5 8648.2 8685.0 8727.0 8748.1 8542.9 8562.1 8627.6 8717.3 8736.9 3751.5 4435.0 4525.4 4537.7 4608.2 1759.4 1803.8 1894.6 1929.0 1941.3 786.5 879.7 900.3 935.8 959.1 19667.8 21492.9 21502.9 21591.8 21685.7 934.2 956.7 963.9 969.5 981.4 8914.7 10241.8 11247.8 11272.8 11288.0 557698.0 580609.0 589708.1 614971.0 632858.0 138162.0 139454.0 140338.0 143014.0 144721.0 970.6 977.9 991.4 994.0 994.9 18004.1 18689.0 19045.0 19304.0 19306.6 48151.8 52328.0 53731.9 55642.0 56831.1 77813.6 78807.6 80187.0 81070.0 81729.0 6909.7 7104.1 7269.6 7294.5 7398.6 7173.8 9568.8 11668.8 12211.7 12595.9 10101.3 10475.3 10962.9 10985.2 11238.0 8826.4 11021.4 11065.3 11183.0 11197.3 9341.0 9437.5 11052.2 11194.4 11327.8 7164.7 7183.3 7349.2 7455.4 7544.1 9821.9 10806.7 10824.4 11096.0 11175.0 14:24:15 INFO - PROCESS | 1654 | 14:24:15 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5769.73 Median:2557.40 stddev:3304.29 (129.2%) stddev-sans-first:3298.03 14:24:15 INFO - PROCESS | 1654 | Values: 1507.4 1511.0 1704.5 1821.5 1867.8 8554.1 9134.1 9141.9 9160.3 9167.2 7891.8 8167.3 8184.3 8701.8 8869.6 2048.8 2381.7 2403.8 2414.1 2416.8 2385.2 2399.6 2423.8 2424.1 2425.3 2004.6 2397.5 2408.4 2417.7 2420.7 2359.5 2375.0 2390.5 2395.3 2396.3 1696.9 2057.0 2061.7 2065.1 2067.5 9017.4 9074.0 9102.5 9115.8 9143.8 5247.3 5430.8 5432.6 5435.8 5438.9 3344.2 3441.6 3490.5 3529.8 3541.3 1032.8 1041.0 1041.2 1062.6 1064.5 11944.8 12073.9 12103.3 12104.0 12109.4 4657.0 4677.1 4849.8 4853.6 4889.9 8646.6 10209.7 10218.6 10235.4 10237.2 5412.0 5412.9 5413.4 5421.9 5430.9 3699.4 4421.0 4560.8 4795.8 4950.4 3940.1 3976.2 4094.4 4106.7 4121.0 1296.4 1320.6 1325.4 1329.9 1335.6 807.6 902.5 904.7 913.7 927.4 5761.9 5918.1 5961.1 6070.1 6195.6 437.9 446.5 455.9 457.5 457.8 3442.6 3913.2 4000.1 4085.6 4097.7 8879.4 10833.1 10971.2 10986.8 11069.3 10475.2 10719.1 10917.8 10919.6 10922.8 8304.2 8399.4 8400.7 8401.7 8425.8 5875.8 6021.5 6037.3 6038.9 6112.9 9891.8 10096.8 10354.6 10379.6 10393.1 10527.7 10529.0 10532.7 10542.6 10557.0 7526.2 7527.5 7594.4 7649.8 7737.5 8408.8 8482.1 8482.2 8490.2 8492.0 7495.9 7629.2 7629.5 7699.3 7760.6 7374.5 7503.2 7534.3 7581.8 7687.7 6962.2 7084.4 7107.9 7109.9 7113.6 4967.9 5038.6 5152.7 5206.5 5212.1 4406.0 5031.1 5058.1 5076.5 5236.9 14:24:15 INFO - PROCESS | 1654 | 14:24:15 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4521.05 Median:4964.88 stddev:1421.99 (28.6%) stddev-sans-first:1390.22 14:24:15 INFO - PROCESS | 1654 | Values: 299.3 305.5 309.2 315.1 315.7 5182.2 5355.0 5391.4 5432.1 5454.7 4876.7 4915.1 5263.8 5284.5 5335.2 3548.7 3920.9 4114.1 4130.3 4135.8 3926.8 4119.6 4145.5 4148.9 4156.8 3873.0 3918.4 3992.2 4027.8 4034.2 4003.2 4024.8 4029.5 4044.8 4069.6 2852.6 3080.7 3101.6 3188.1 3485.3 4597.6 4805.9 4988.7 5283.4 5386.3 4293.9 4449.3 4634.9 4638.4 4647.5 4812.5 5633.7 5652.3 5681.6 5719.8 3665.3 3794.3 3896.0 3901.1 3912.6 5817.5 5840.9 5889.0 5900.9 5964.3 3741.2 3749.1 3750.5 3754.8 3773.6 3775.3 3785.7 3787.0 3805.4 3807.3 3761.4 4258.5 4541.4 4564.3 4576.9 4906.5 4965.9 5667.5 5681.9 5713.1 1137.8 1348.5 1350.8 1351.3 1356.1 729.5 805.6 817.4 824.7 837.6 3626.7 4403.0 4481.9 4490.3 4543.5 4313.9 4449.1 4879.7 4963.8 4981.3 4826.8 5063.4 5146.8 5163.9 5305.0 2795.9 2930.4 3017.7 3026.5 3031.9 5300.6 5331.5 5486.9 5493.9 6002.3 4960.9 5266.8 5394.7 5553.1 6011.3 5860.6 6039.0 6055.4 6059.8 6071.7 4633.6 5730.0 5850.8 5898.5 5915.8 4609.6 5837.8 5859.8 5868.1 5871.5 5660.7 5863.7 5878.4 6127.4 6162.6 3314.1 3797.9 3885.6 3893.4 3896.3 5842.5 5848.1 5874.6 5901.3 5938.4 5544.3 5692.3 5720.5 5757.3 5765.8 5651.9 5663.7 5671.4 5676.0 5731.8 4632.4 4734.3 5497.8 5595.9 5666.3 5312.7 5687.0 5730.3 5780.3 5781.8 5140.4 5317.1 5621.3 5636.0 5647.4 14:24:15 INFO - PROCESS | 1654 | 14:24:15 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24330.87 Median:4455.63 stddev:38983.13 (874.9%) stddev-sans-first:39052.08 14:24:15 INFO - PROCESS | 1654 | Values: 691.4 707.5 766.1 768.6 810.9 13643.5 13654.8 15136.5 16467.4 16482.8 14746.9 14903.4 14933.3 14951.7 14958.7 658.8 674.1 817.2 828.8 843.9 852.6 860.8 864.7 864.7 867.4 910.6 912.3 912.5 914.0 914.7 691.4 711.5 905.8 907.4 909.4 648.8 660.0 667.5 669.4 669.6 14970.8 15028.4 15033.5 15037.5 15052.3 13883.7 14113.6 14151.2 14197.4 14233.2 11744.9 11980.4 12050.8 12150.9 12324.9 4564.3 4604.7 4716.4 4737.1 4771.9 97760.0 100303.0 119294.2 126912.1 127726.0 9522.2 10935.5 11414.9 11443.7 11730.1 22745.9 22884.9 22932.2 23004.0 23055.9 8060.0 8088.0 8109.1 8185.6 8292.8 4364.9 4451.5 4462.8 4696.9 4722.0 3321.4 3428.6 3429.2 3432.5 3433.6 605.5 612.2 624.9 626.6 631.7 549.4 595.8 599.5 611.9 618.1 9069.0 9124.5 9135.9 9182.2 9237.0 616.2 621.9 628.0 641.2 641.6 4220.9 4459.8 4519.1 4545.7 4557.3 86444.3 123581.4 143325.0 149000.0 149498.0 127472.0 129595.0 130026.0 134050.0 136624.3 110332.8 111391.4 111778.0 113325.0 115835.0 8576.3 8583.6 8614.1 8657.4 8759.1 60578.0 60660.4 60758.1 61031.0 62698.7 73901.3 92496.6 92874.0 94763.5 98426.0 11550.9 11622.8 11741.7 12246.1 12309.5 12159.9 12205.6 12396.9 13002.4 13014.6 11775.3 11864.0 11879.6 12462.1 12530.8 11587.4 11668.4 11942.0 11991.0 12557.8 11794.4 11826.1 12171.4 12275.1 12327.0 9703.8 9879.5 10206.7 10217.6 10365.5 9950.9 9980.6 10011.8 10042.6 10109.4 14:24:15 INFO - PROCESS | 1654 | -------- Summary: end -------- 14:24:15 INFO - PROCESS | 1654 | 14:24:15 INFO - TEST-INFO | 1654: exit 0 14:24:15 INFO - TEST-OK | dromaeo_css | took 1116714ms 14:24:15 INFO - TEST-START | kraken 14:24:15 INFO - operating with platform_type : mac_ 14:24:15 INFO - Initialising browser for kraken test... 14:24:15 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp50ldbv/profile http://localhost:49272/getInfo.html) 14:24:18 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 14:24:18 INFO - PROCESS | 1663 | colorDepth:24 14:24:18 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 14:24:18 INFO - PROCESS | 1663 | __metrics 14:24:18 INFO - PROCESS | 1663 | 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:24:18 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:19 INFO - TEST-INFO | 1663: exit 0 14:24:19 INFO - Browser initialized. 14:24:19 INFO - Running cycle 1/1 for kraken test... 14:24:19 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmp50ldbv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:31 INFO - PROCESS | 1665 | RSS: Main: 219615232 14:24:31 INFO - PROCESS | 1665 | 14:24:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 14:24:34 INFO - PROCESS | 1665 | RSS: Main: 270761984 14:24:34 INFO - PROCESS | 1665 | 14:24:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 14:24:38 INFO - PROCESS | 1665 | RSS: Main: 282439680 14:24:38 INFO - PROCESS | 1665 | 14:24:41 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 14:24:42 INFO - PROCESS | 1665 | RSS: Main: 379752448 14:24:42 INFO - PROCESS | 1665 | 14:24:44 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 14:24:44 INFO - PROCESS | 1665 | RSS: Main: 279777280 14:24:44 INFO - PROCESS | 1665 | 14:24:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:47 INFO - PROCESS | 1665 | RSS: Main: 281513984 14:24:47 INFO - PROCESS | 1665 | 14:24:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:50 INFO - PROCESS | 1665 | RSS: Main: 319938560 14:24:50 INFO - PROCESS | 1665 | 14:24:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:54 INFO - PROCESS | 1665 | RSS: Main: 319475712 14:24:54 INFO - PROCESS | 1665 | 14:24:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 14:24:57 INFO - PROCESS | 1665 | RSS: Main: 318361600 14:24:57 INFO - PROCESS | 1665 | 14:24:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:59 INFO - PROCESS | 1665 | RSS: Main: 295677952 14:24:59 INFO - PROCESS | 1665 | 14:25:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:25:02 INFO - PROCESS | 1665 | RSS: Main: 297623552 14:25:02 INFO - PROCESS | 1665 | 14:25:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:25:05 INFO - PROCESS | 1665 | RSS: Main: 302288896 14:25:05 INFO - PROCESS | 1665 | 14:25:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:08 INFO - PROCESS | 1665 | RSS: Main: 308838400 14:25:08 INFO - PROCESS | 1665 | 14:25:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:25:12 INFO - PROCESS | 1665 | RSS: Main: 309202944 14:25:12 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 14:25:14 INFO - PROCESS | 1665 | RSS: Main: 352698368 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | __start_tp_report 14:25:14 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 14:25:14 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 14:25:14 INFO - PROCESS | 1665 | |i|pagename|runs| 14:25:14 INFO - PROCESS | 1665 | |0;ai-astar;116;113;114;114;115;114;113;114;113;112 14:25:14 INFO - PROCESS | 1665 | |1;audio-beat-detection;150;138;138;140;108;131;137;109;139;109 14:25:14 INFO - PROCESS | 1665 | |2;audio-dft;184;182;181;185;189;259;220;182;181;186 14:25:14 INFO - PROCESS | 1665 | |3;audio-fft;81;58;59;91;61;61;61;76;75;69 14:25:14 INFO - PROCESS | 1665 | |4;audio-oscillator;86;70;94;70;67;68;93;67;69;91 14:25:14 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;87;85;88;85;87;83;88;85;87;84 14:25:14 INFO - PROCESS | 1665 | |6;imaging-darkroom;110;150;111;93;93;93;93;93;93;93 14:25:14 INFO - PROCESS | 1665 | |7;imaging-desaturate;84;85;84;85;83;84;86;83;84;93 14:25:14 INFO - PROCESS | 1665 | |8;json-parse-financial;55;53;54;53;56;56;57;56;57;56 14:25:14 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;63;71;66;75;71;69;69;69;73;75 14:25:14 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;94;100;90;85;85;81;81;82;85;84 14:25:14 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;140;138;140;138;136;139;150;152;172;138 14:25:14 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;163;163;164;164;225;221;162;162;162;163 14:25:14 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;67;67;67;66;66;66;66;64;66;65 14:25:14 INFO - PROCESS | 1665 | __end_tp_report 14:25:14 INFO - PROCESS | 1665 | __start_cc_report 14:25:14 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2083 14:25:14 INFO - PROCESS | 1665 | __end_cc_report 14:25:14 INFO - PROCESS | 1665 | __startTimestamp1477517114457__endTimestamp 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | ------- Summary: start ------- 14:25:14 INFO - PROCESS | 1665 | Number of tests: 14 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:1.14 (1.0%) stddev-sans-first:0.88 14:25:14 INFO - PROCESS | 1665 | Values: 116.0 113.0 114.0 114.0 115.0 114.0 113.0 114.0 113.0 112.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:138.00 stddev:15.37 (11.1%) stddev-sans-first:14.47 14:25:14 INFO - PROCESS | 1665 | Values: 150.0 138.0 138.0 140.0 108.0 131.0 137.0 109.0 139.0 109.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:194.90 Median:185.50 stddev:25.36 (13.7%) stddev-sans-first:26.59 14:25:14 INFO - PROCESS | 1665 | Values: 184.0 182.0 181.0 185.0 189.0 259.0 220.0 182.0 181.0 186.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:69.20 Median:72.00 stddev:11.18 (15.5%) stddev-sans-first:11.02 14:25:14 INFO - PROCESS | 1665 | Values: 81.0 58.0 59.0 91.0 61.0 61.0 61.0 76.0 75.0 69.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.00 stddev:11.84 (15.2%) stddev-sans-first:12.16 14:25:14 INFO - PROCESS | 1665 | Values: 86.0 70.0 94.0 70.0 67.0 68.0 93.0 67.0 69.0 91.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.73 (2.0%) stddev-sans-first:1.79 14:25:14 INFO - PROCESS | 1665 | Values: 87.0 85.0 88.0 85.0 87.0 83.0 88.0 85.0 87.0 84.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:93.00 stddev:18.30 (19.7%) stddev-sans-first:19.20 14:25:14 INFO - PROCESS | 1665 | Values: 110.0 150.0 111.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:84.50 stddev:2.92 (3.5%) stddev-sans-first:3.07 14:25:14 INFO - PROCESS | 1665 | Values: 84.0 85.0 84.0 85.0 83.0 84.0 86.0 83.0 84.0 93.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.49 (2.7%) stddev-sans-first:1.58 14:25:14 INFO - PROCESS | 1665 | Values: 55.0 53.0 54.0 53.0 56.0 56.0 57.0 56.0 57.0 56.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:3.78 (5.3%) stddev-sans-first:3.02 14:25:14 INFO - PROCESS | 1665 | Values: 63.0 71.0 66.0 75.0 71.0 69.0 69.0 69.0 73.0 75.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.00 stddev:6.18 (7.3%) stddev-sans-first:5.97 14:25:14 INFO - PROCESS | 1665 | Values: 94.0 100.0 90.0 85.0 85.0 81.0 81.0 82.0 85.0 84.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:140.00 stddev:11.12 (7.9%) stddev-sans-first:11.68 14:25:14 INFO - PROCESS | 1665 | Values: 140.0 138.0 140.0 138.0 136.0 139.0 150.0 152.0 172.0 138.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:163.50 stddev:25.38 (15.5%) stddev-sans-first:26.55 14:25:14 INFO - PROCESS | 1665 | Values: 163.0 163.0 164.0 164.0 225.0 221.0 162.0 162.0 162.0 163.0 14:25:14 INFO - PROCESS | 1665 | 14:25:14 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 14:25:14 INFO - PROCESS | 1665 | Values: 67.0 67.0 67.0 66.0 66.0 66.0 66.0 64.0 66.0 65.0 14:25:14 INFO - PROCESS | 1665 | -------- Summary: end -------- 14:25:14 INFO - PROCESS | 1665 | 14:25:15 INFO - TEST-INFO | 1665: exit 0 14:25:15 INFO - TEST-OK | kraken | took 59382ms 14:25:15 INFO - SUITE-END | took 1176s 14:25:15 INFO - Completed test suite (00:19:36) 14:25:15 INFO - javascript benchmark 14:25:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2819.0, 3351.681590248927, 3376.966230337696, 3412.0616830371628, 3416.7095796857266, 5657.066584013638, 5667.688277144755, 5686.488216060554, 5686.971565142168, 5702.372738998707, 5647.37878833328, 5727.455891690282, 5727.997600419931, 5734.655920644765, 5748.425157484249, 5206.609504287194, 5216.7391630418515, 5236.450172731856, 5241.9213711794355, 5284.603654725892, 5197.272381866523, 5206.3231779868565, 5208.401033881114, 5295.655782374133, 5301.3373328333955, 4293.570642935712, 5221.399539053001, 5255.001549705563, 5257.421683614799, 5273.0, 5226.372835259755, 5237.214417837316, 5276.393214780311, 5287.7884884604955, 5338.759755810997, 5100.464451232604, 5161.896762064737, 5229.346331708536, 5248.186531087687, 5248.8425347239645, 5558.527525160366, 5586.35756887955, 5637.577181711388, 5638.323401191842, 5641.097424412074, 6215.06773983906, 6250.937490625081, 6267.2165979252595, 6278.780242691484, 6285.654289014103, 5945.702714864239, 6240.219972503437, 6339.207599050119, 6353.332900045475, 6356.396142366514, 5536.307961504772, 5566.916496252559, 5567.220589117527, 5598.86002849932, 5605.971970140124, 6236.282827474898, 6237.906431403532, 6241.188645476059, 6245.18812554365, 6247.125402443661, 5862.179294898718, 5871.031279838779, 5872.148538461985, 5877.412258774174, 5924.437178468039, 6129.48104857405, 6132.938670613326, 6144.723487443076, 6199.969000154971, 6238.625682459067, 6197.318294987548, 6212.47193988507, 6212.9378706213265, 6214.720337584819, 6226.470749986212, 6097.3292937776805, 6174.104754810527, 6220.782272620527, 6233.189685340877, 6238.251409830758, 4721.787519561628, 4768.046390721869, 4770.974240538301, 4876.5854902333695, 4964.0, 4410.933835992462, 4423.1153769246275, 4424.358468022118, 4479.216137176047, 4500.077484115814, 5799.420057994167, 5808.303003639506, 5810.50610698087, 5818.2436283282905, 5865.413458654186, 6097.451229389376, 6189.0, 6313.116163737081, 6314.842128946813, 6328.272248691367, 5738.340090889517, 5751.166080918243, 5812.970935145382, 5819.214406055213, 5869.941300587025, 5356.651817631841, 5403.594730395236, 5410.78356865721, 5412.621116521885, 5414.431484694129, 6337.0, 6344.270408903035, 6365.649889256136, 6368.044793280859, 6376.872462550723, 6119.898632333015, 6127.494965204967, 6199.907001395073, 6248.781292654735, 6251.78118765841, 6271.96864015677, 6311.684415779285, 6314.0, 6334.556581039283, 6334.90497642545, 6156.876862462816, 6179.505639548735, 6185.783497577563, 6191.473724733268, 6204.348543402878, 4917.877053073702, 6119.541034422525, 6145.310039739107, 6179.536534760001, 6240.781572644935, 6042.0936859469675, 6073.99779036454, 6078.118672792509, 6084.939150608614, 6125.754969801158, 4991.5258050485145, 6050.21347224858, 6105.267367915879, 6113.449789518964, 6117.357677443804, 5671.602987790815, 5770.653760774367, 5838.416158384298, 5921.3782552831335, 5945.583809133319, 6082.513398928164, 6123.68219977123, 6139.298708568215, 6151.384861513813, 6154.292256390572, 5908.497777688945, 5948.405159484017, 5948.791792287422, 5965.582409231312, 5986.610870293417], "value": 5667.713376493517, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.14808160657964, 534.6311045378689, 536.2519285596593, 545.0053652084945, 551.0741953518088, 30874.382512349766, 40708.592914070854, 42079.36880946788, 42136.15727685448, 44261.0, 41865.58134418655, 43258.78370608151, 43542.0, 43631.78184109083, 43755.562444375544, 9687.370320929118, 9890.90109098907, 9891.604335826594, 9892.950535247313, 9896.455694936776, 8810.074942131048, 9023.503707296097, 12079.879201208007, 12313.876861231407, 12334.0, 12163.209391389575, 12272.447739851728, 12276.079294052981, 12297.3236471994, 12325.013998880113, 8809.823803523957, 12279.570215042475, 12349.814752778715, 12353.814692779615, 12370.319632420213, 8664.523451210243, 8890.066543012956, 8900.287976961827, 8912.420692655021, 11674.0, 39292.80353598242, 41543.75368738943, 41639.75080747582, 41724.58275417237, 41808.95477613054, 3328.2012317043977, 3377.645347238529, 3654.5797233318244, 3921.156951255494, 4090.7545547266964, 30086.097417077523, 30273.545896811567, 30274.940377086918, 31320.843395783104, 32692.0, 3255.8372081395837, 3290.457074582691, 3301.240714635623, 3334.71654909333, 3385.746069044807, 525508.0, 531813.363732727, 532318.9999999962, 534102.0, 535625.0, 61949.451263718765, 62422.68788656028, 62628.37371626226, 62667.686661566404, 62702.0, 65211.347886520525, 65348.0, 65382.0, 65424.672876636265, 65549.34450655528, 15644.296006679726, 17088.974661520348, 17112.657746844994, 17121.630269578654, 17148.142592870307, 11803.23278986863, 12115.39423028845, 13121.409536570878, 13189.47242110324, 13223.603291901258, 15229.314680839389, 16710.83289167093, 16991.83008169927, 17192.0, 17483.300667973137, 6076.513878889678, 6113.38866113394, 6140.0, 6178.814635560941, 6212.9378706213265, 831.8752187171973, 915.6566287642135, 929.6746138851348, 957.5212393803098, 1035.8446233065101, 29199.56200656992, 30116.54825177624, 30166.547501787492, 30300.69699302979, 30936.535951960737, 991.3308516751164, 1033.1837848100067, 1045.5451878432907, 1045.7124290819934, 1050.5955207245265, 15627.765583516257, 15747.921260393625, 15807.68384632324, 15868.52394428169, 16089.275982580577, 680502.0, 686893.0, 689517.0, 690496.0, 692196.0, 57160.71419642958, 57508.0, 57585.42414575884, 57643.0, 57644.42355576474, 1218.500414829933, 1260.24385368778, 1350.7973803929096, 1359.8708122728326, 1389.1387339849357, 29996.850015750653, 30742.077737667907, 31960.68039319577, 31996.84001579977, 32598.0, 49775.75112124416, 50171.74914125406, 50300.24549631685, 50339.74830125826, 50362.0, 553374.0, 553617.0, 555532.0, 556256.0, 557677.6928922797, 26230.4753904917, 26828.59757103684, 26964.865175673996, 27172.592411113455, 27543.449131017667, 47596.0, 47984.5201547994, 48023.0, 48537.27194092162, 48608.51391486181, 39082.80458597689, 39479.2104157921, 39671.40492892667, 39795.80102099471, 41408.58591414047, 39568.80215598903, 39767.80116099401, 40040.31372862135, 41191.382129267484, 41354.379684305364, 38226.617733822306, 39451.40822887716, 39620.405693914036, 39736.20527589374, 39744.403833941935, 31075.844620776752, 34665.65334346624, 35278.64721352753, 35559.82220088883, 35873.64126358808, 26132.34669133287, 26260.4747905037, 26269.0, 26383.682909323034, 26720.19839404821], "value": 20448.436575128115, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.4252558023459, 354.36922278344554, 376.33952413514294, 385.96140385961405, 404.06862182668937, 14902.77645835312, 14984.700305993874, 16078.035317880935, 20707.792922070774, 21127.366179014654, 19953.501162470944, 20782.89608551955, 20793.584128317423, 21379.57240855182, 21636.918154092313, 4492.0, 5724.084146536555, 5970.910436343458, 5972.0444728843395, 5977.9837427637185, 4146.66826653867, 4381.583749543788, 5895.764169433218, 5919.230500035011, 5995.760169593211, 4244.851430199944, 6281.842953926165, 6580.111684922546, 6603.0, 6681.331866813304, 6382.585131966431, 6487.83780405489, 6504.349565043505, 6539.869202615921, 6663.433608143314, 5678.914816277759, 5684.317881854204, 5684.857878553028, 5688.772449102031, 5698.572607054488, 24121.517569648684, 24195.395115122086, 24979.62530562043, 25203.49593008148, 25313.0, 2160.459885028743, 2210.1490925993608, 2280.2817112609473, 2351.729551101628, 2385.3678775124604, 9420.0, 9865.358751681119, 10243.231757618209, 10426.68719938403, 10471.738206544822, 1857.2942281932778, 1864.3940719266293, 1870.532366908273, 1924.7497825282624, 1939.4084804134734, 120931.32549396028, 127457.0, 129321.0, 131428.0, 132109.33945330212, 9291.002434476484, 11497.367644779617, 11625.644275243352, 11647.0, 11847.940760296144, 14825.0, 14878.479253226085, 14883.702325953636, 14889.776653350209, 14890.776638350433, 8321.500709957421, 8648.1784230498, 8685.002449436664, 8727.04002559718, 8748.081451447633, 8542.871856922151, 8562.100979397073, 8627.568621569022, 8717.346199035097, 8736.8689469658, 3751.4619006207868, 4434.955650443519, 4525.434320709911, 4537.705049171794, 4608.170529304757, 1759.4369801663345, 1803.8110889384534, 1894.6400183965002, 1928.98071019288, 1941.3011315926256, 786.5162924801206, 879.7316818370458, 900.2527901841587, 935.7941252924346, 959.0888655777039, 19667.803321966596, 21492.892535537223, 21502.89248553747, 21591.78408215929, 21685.67471487929, 934.1639232886664, 956.6556039825657, 963.9084286992725, 969.5443141723379, 981.4454833019321, 8914.73255802327, 10241.795164096826, 11247.83128253077, 11272.830907536394, 11287.98408143271, 557698.0, 580609.0, 589708.0514597399, 614971.0, 632858.0, 138162.0, 139454.0, 140338.0, 143014.0, 144721.0, 970.6069042037985, 977.8679878216492, 991.3952488981715, 993.9552720127612, 994.9403035817729, 18004.099795010457, 18688.97210653427, 19045.04774761284, 19304.03479825975, 19306.613867722284, 48151.75924120497, 52328.0, 53731.92536149333, 55642.0, 56831.14753278621, 77813.61093194498, 78807.60596197212, 80187.0, 81070.0, 81729.0, 6909.723611055501, 7104.076470058859, 7269.636518173965, 7294.452916031213, 7398.556086634604, 7173.820654483679, 9568.76078098053, 11668.824967625322, 12211.69470763238, 12595.88493807453, 10101.343412678152, 10475.266731329039, 10962.945185274022, 10985.231033827555, 11238.0, 8826.426282291888, 11021.44892755343, 11065.280756750786, 11183.049440797624, 11197.320401939774, 9341.0, 9437.480938548446, 11052.171087168656, 11194.384308863091, 11327.830082548604, 7164.749233776793, 7183.317584829433, 7349.154847192642, 7455.440841936768, 7544.0569928758905, 9821.901780982098, 10806.675799726021, 10824.350538967687, 11096.0, 11175.0], "value": 9424.0813285847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.3744396075626, 1510.9848901510984, 1704.5056933489288, 1821.4808779497846, 1867.8038805925387, 8554.05905350411, 9134.132257435542, 9141.862872056925, 9160.312976526771, 9167.220786233178, 7891.802704932379, 8167.346612271019, 8184.263416292532, 8701.782455438617, 8869.645214191425, 2048.832165665571, 2381.7499162587897, 2403.807695384365, 2414.0947144820693, 2416.806655467567, 2385.2009576791797, 2399.5560821248123, 2423.75762423758, 2424.103081859714, 2425.3451568076607, 2004.5990801839619, 2397.5324811661735, 2408.4099395648004, 2417.6615273861676, 2420.673209116764, 2359.539889721505, 2374.964375534368, 2390.4740956989435, 2395.3412811476983, 2396.3290278721897, 1696.923638436261, 2056.95886082279, 2061.7114303560274, 2065.0500769645982, 2067.503799088223, 9017.36878418511, 9074.0, 9102.499362535058, 9115.817683646355, 9143.817123657489, 5247.291615631879, 5430.755615997289, 5432.592555558309, 5435.755391007414, 5438.945610543923, 3344.180675734436, 3441.6042155152227, 3490.493878387645, 3529.8058606776617, 3541.29174165168, 1032.8037672842136, 1040.9895901041043, 1041.1930753665895, 1062.617457715222, 1064.473085822515, 11944.820827687592, 12073.93963030188, 12103.334316612583, 12104.0, 12109.394530273452, 4656.976715116402, 4677.129148340691, 4849.80600775965, 4853.611711063107, 4889.853304400874, 8646.610902509403, 10209.693709188736, 10218.642347517802, 10235.43705096212, 10237.23220758446, 5412.025835349675, 5412.864678383072, 5413.377461591967, 5421.864453388618, 5430.864228394322, 3699.3711069117776, 4421.049474363027, 4560.794764235618, 4795.784189711471, 4950.4059512858685, 3940.0937784309767, 3976.2445135424177, 4094.447249621263, 4106.7125301228625, 4121.031557583965, 1296.4490091710986, 1320.5972178485463, 1325.436689406998, 1329.9202047877159, 1335.5525898824003, 807.5679511461458, 902.5081330674798, 904.6562306323555, 913.7350168451208, 927.3647551427293, 5761.942380576141, 5918.112283157475, 5961.135635332939, 6070.089486576961, 6195.628262304276, 437.949635791888, 446.5066101957355, 455.92249317616086, 457.5310306935351, 457.8168732506957, 3442.5524681791208, 3913.178232571192, 4000.139969906484, 4085.55058943516, 4097.651699605567, 8879.378443508893, 10833.133349332034, 10971.177161712903, 10986.780264394667, 11069.280496767846, 10475.161987041018, 10719.142468602493, 10917.781644367069, 10919.617813376653, 10922.781544369069, 8304.211099945496, 8399.37004724648, 8400.705975290835, 8401.747947561584, 8425.789355266044, 5875.794347197828, 6021.458068773656, 6037.305709843248, 6038.882806680778, 6112.8777424452155, 9891.802163956825, 10096.798064038825, 10354.637587684394, 10379.636712715019, 10393.06462418386, 10527.684169474622, 10529.0, 10532.736681583021, 10542.631007914686, 10557.0, 7526.209747976383, 7527.548347099191, 7594.392448604209, 7649.770506884803, 7737.497062691133, 8408.83182336362, 8482.066972633129, 8482.151784821468, 8490.193431623986, 8491.95754021226, 7495.925040749523, 7629.237076292548, 7629.504082234637, 7699.345555627834, 7760.611969401621, 7374.520656157332, 7503.174650788518, 7534.284242996907, 7581.772546823604, 7687.730929417444, 6962.199347075151, 7084.36240738336, 7107.893381599177, 7109.857802844018, 7113.608751518716, 4967.875803104951, 5038.589633647837, 5152.742362881766, 5206.453322401245, 5212.113940630178, 4405.986623076775, 5031.144705400164, 5058.064258112261, 5076.517730815566, 5236.947630523646], "value": 4527.45665859643, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.29217400846994, 305.5401620561054, 309.17142059281133, 315.1255266635087, 315.7205872802569, 5182.248573956784, 5355.010517164717, 5391.406945236021, 5432.103702889023, 5454.727263636817, 4876.6586338956195, 4915.090708218982, 5263.842084737464, 5284.524392804647, 5335.239371007568, 3548.7338449616254, 3920.862949744571, 4114.07900390723, 4130.256553820311, 4135.793210339471, 3926.7840268785208, 4119.649829764474, 4145.461090058288, 4148.854790082348, 4156.771377574232, 3873.0, 3918.392649139388, 3992.2414741199223, 4027.7986100694993, 4034.1931613677234, 4003.1593365393155, 4024.8126802593306, 4029.49631296088, 4044.757314561136, 4069.552349241581, 2852.6006359109742, 3080.6919308069014, 3101.573276292908, 3188.1232661018175, 3485.3203625293077, 4597.574861663236, 4805.879853003668, 4988.7006779592975, 5283.392409872876, 5386.326709161355, 4293.892652683677, 4449.26587113126, 4634.884127896829, 4638.420197475316, 4647.465541462708, 4812.542808433193, 5633.746481408347, 5652.34997975234, 5681.608006038547, 5719.771209151629, 3665.2852693724735, 3794.29805485986, 3895.9546238224875, 3901.141748815256, 3912.6478616924614, 5817.534597232211, 5840.883182336372, 5889.028310328834, 5900.940990590125, 5964.343922168558, 3741.1582393961685, 3749.1002159482073, 3750.493683352767, 3754.81225938702, 3773.603771603942, 3775.2826962876966, 3785.73499855013, 3786.981065094657, 3805.3530899746556, 3807.333716599584, 3761.4357846322723, 4258.467691538558, 4541.409616749801, 4564.269716845289, 4576.8626941191815, 4906.4918583213175, 4965.925511117336, 5667.489925906688, 5681.9431805681415, 5713.114467257582, 1137.761070175256, 1348.4673553946136, 1350.7906274527463, 1351.2973653197043, 1356.0846428660614, 729.5403895545772, 805.595298035364, 817.4032955942196, 824.7340332589447, 837.5937670229933, 3626.6581364894632, 4402.974631669468, 4481.865544033684, 4490.348899409567, 4543.522930092358, 4313.923342441425, 4449.1101779644205, 4879.707217566957, 4963.8262660806695, 4981.277714731344, 4826.7827947742435, 5063.443021267732, 5146.819861304836, 5163.948360516422, 5304.973475132677, 2795.9440811183663, 2930.369970456362, 3017.698230176965, 3026.4854974654363, 3031.9393612127633, 5300.628955973122, 5331.546818520392, 5486.862828429242, 5493.862653433696, 6002.339742628307, 4960.90078198434, 5266.8419947401635, 5394.703291319015, 5553.056430249461, 6011.308699499614, 5860.589758716934, 6038.969805150946, 6055.424734650202, 6059.818205453844, 6071.664233868453, 4633.606143477842, 5730.0, 5850.765969361178, 5898.469137777621, 5915.763369465173, 4609.562091601292, 5837.781642975642, 5859.765609375577, 5868.119782032559, 5871.500922421642, 5660.660360378391, 5863.677497737665, 5878.441548052928, 6127.3566275540425, 6162.599431036968, 3314.1217577342504, 3797.943030854595, 3885.5725870154824, 3893.357595996629, 3896.298666239991, 5842.474177324061, 5848.064309710426, 5874.56338042233, 5901.3213480450295, 5938.4061593842, 5544.306961629796, 5692.31692196939, 5720.511577463816, 5757.337906140848, 5765.769369225184, 5651.915221271766, 5663.716814159193, 5671.376148623565, 5676.035074037506, 5731.770729170787, 4632.3977882875015, 4734.325106314921, 5497.783796479104, 5595.944040559542, 5666.263385759825, 5312.6546774461085, 5686.9715651421475, 5730.283714535683, 5780.3352614448195, 5781.79763708285, 5140.357455318085, 5317.065371625047, 5621.29438619793, 5635.98552260597, 5647.3505546861], "value": 4062.570380576448, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.4157536881333, 707.5294928872297, 766.1151370167458, 768.5696010234269, 810.9270165685089, 13643.454261829527, 13654.795178072336, 15136.470223542177, 16467.423640172598, 16482.83517164828, 14746.926265368686, 14903.403863845433, 14933.253337333144, 14951.700965980674, 14958.700825983473, 658.805652332563, 674.1101745695684, 817.1746535998655, 828.7845160258346, 843.9156084391573, 852.6163226548078, 860.8235311761106, 864.7146441674232, 864.7449002544233, 867.41449521573, 910.6129894794719, 912.3476714149382, 912.4935660708304, 914.008300993423, 914.7301546043933, 691.3639451704444, 711.4521818199958, 905.814308066848, 907.3557773980515, 909.3589019741132, 648.7761722205831, 660.0396423204227, 667.5260564998856, 669.3875104279628, 669.5714742564713, 14970.775438368433, 15028.398864045424, 15033.548993530103, 15037.548873533811, 15052.32264548098, 13883.652908677364, 14113.576592702235, 14151.221682807442, 14197.432102715879, 14233.217173055478, 11744.882551174464, 11980.374130626022, 12050.758984820342, 12150.939245303805, 12324.938375308066, 4564.269716845289, 4604.654650901162, 4716.434027916637, 4737.147313483571, 4771.928421073687, 97759.99999999929, 100303.0, 119294.2105868404, 126912.0963185553, 127726.0, 9522.190613797904, 10935.453227338601, 11414.94292528532, 11443.713907152222, 11730.12024098179, 22745.886270568542, 22884.88557557235, 22932.16542676582, 23004.0, 23055.88472057629, 8060.03279606451, 8088.029436467662, 8109.067457242375, 8185.590720463953, 8292.792680182924, 4364.912701745948, 4451.488078870907, 4462.843800466968, 4696.882577935579, 4721.95278047222, 3321.352336294448, 3428.5542879425516, 3429.1598558352866, 3432.5022871683964, 3433.639467855889, 605.4762630324738, 612.2071916867578, 624.9125122482856, 626.5676683088654, 631.6841579210395, 549.4203615186017, 595.809341010881, 599.487438240307, 611.8562137897591, 618.11300783376, 9068.957603695906, 9124.49815260167, 9135.908640913505, 9182.17360437564, 9237.0, 616.1774031667774, 621.9209671220428, 627.9699606154734, 641.1952998986336, 641.592588706175, 4220.873373798791, 4459.777011149495, 4519.141363140992, 4545.704529205591, 4557.323987013124, 86444.27111457735, 123581.38209309075, 143325.0, 149000.0, 149498.0, 127472.0, 129595.0, 130026.0, 134050.0, 136624.31687841695, 110332.79334413428, 111391.4430427875, 111778.0, 113325.0, 115835.0, 8576.271016963628, 8583.613737381707, 8614.052454230155, 8657.39398242117, 8759.080296568769, 60578.0, 60660.39339606724, 60758.08862867149, 61030.98757599467, 62698.68650656717, 73901.30441459772, 92496.61255081314, 92874.0, 94763.52618236865, 98426.0, 11550.94224528872, 11622.82565761531, 11741.706457338634, 12246.14277000637, 12309.507619695112, 12159.939200303941, 12205.572804951784, 12396.884280414806, 13002.414891329723, 13014.609561713163, 11775.293482391084, 11864.0, 11879.58421455245, 12462.127651064338, 12530.812037819258, 11587.362695051854, 11668.358240296866, 11942.0, 11991.0, 12557.811632825333, 11794.410279486163, 11826.053915686896, 12171.39143042862, 12275.140740148105, 12327.013838893046, 9703.805923881624, 9879.50602469888, 10206.693799186036, 10217.642382516577, 10365.533550990374, 9950.850737239092, 9980.550875210487, 10011.799764004825, 10042.598296068076, 10109.39343639384], "value": 7619.277676552755, "unit": "score"}], "name": "dromaeo_css", "value": 7313.982504101641, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 113.0, 112.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 138.0, 138.0, 140.0, 108.0, 131.0, 137.0, 109.0, 139.0, 109.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 181.0, 185.0, 189.0, 259.0, 220.0, 182.0, 181.0, 186.0], "value": 194.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 91.0, 61.0, 61.0, 61.0, 76.0, 75.0, 69.0], "value": 69.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 94.0, 70.0, 67.0, 68.0, 93.0, 67.0, 69.0, 91.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 87.0, 83.0, 88.0, 85.0, 87.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 150.0, 111.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0], "value": 102.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 83.0, 84.0, 86.0, 83.0, 84.0, 93.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 53.0, 56.0, 56.0, 57.0, 56.0, 57.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 66.0, 75.0, 71.0, 69.0, 69.0, 69.0, 73.0, 75.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 100.0, 90.0, 85.0, 85.0, 81.0, 81.0, 82.0, 85.0, 84.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 140.0, 138.0, 136.0, 139.0, 150.0, 152.0, 172.0, 138.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 164.0, 225.0, 221.0, 162.0, 162.0, 162.0, 163.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 64.0, 66.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1455.8, "alertThreshold": 2.0}]} 14:25:15 INFO - Return code: 0 14:25:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:25:15 INFO - # TBPL SUCCESS # 14:25:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:25:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:25:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:25:15 INFO - 2016-10-26 14:25:15.807 screenresolution[1669:9963] starting screenresolution argv=screenresolution get 14:25:15 INFO - 2016-10-26 14:25:15.810 screenresolution[1669:9963] Display 0: 1600x1200x32@60 14:25:15 INFO - 2016-10-26 14:25:15.816 screenresolution[1670:9966] starting screenresolution argv=screenresolution list 14:25:15 INFO - Available Modes on Display 0 14:25:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:25:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:25:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:25:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:25:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:25:16 INFO - Intel Iris: 14:25:16 INFO - Chipset Model: Intel Iris 14:25:16 INFO - Type: GPU 14:25:16 INFO - Bus: Built-In 14:25:16 INFO - VRAM (Dynamic, Max): 1536 MB 14:25:16 INFO - Vendor: Intel (0x8086) 14:25:16 INFO - Device ID: 0x0a2e 14:25:16 INFO - Revision ID: 0x0009 14:25:16 INFO - Displays: 14:25:16 INFO - Display: 14:25:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:25:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:25:16 INFO - Display Serial Number: 1600x1200 60 14:25:16 INFO - Main Display: Yes 14:25:16 INFO - Mirror: Off 14:25:16 INFO - Online: Yes 14:25:16 INFO - Rotation: Supported 14:25:16 INFO - Return code: 0 14:25:16 INFO - Running post-action listener: _resource_record_post_action 14:25:16 INFO - [mozharness: 2016-10-26 21:25:16.052128Z] Finished run-tests step (success) 14:25:16 INFO - Running post-run listener: _resource_record_post_run 14:25:16 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37602304; Write bytes: 663196672; Read time: 233; Write time: 1902 14:25:16 INFO - TinderboxPrint: CPU usage
53.3% 14:25:16 INFO - TinderboxPrint: I/O read bytes / time
37,602,304 / 233 14:25:16 INFO - TinderboxPrint: I/O write bytes / time
663,196,672 / 1,902 14:25:16 INFO - TinderboxPrint: CPU idle
2,260.8 (46.7%) 14:25:16 INFO - TinderboxPrint: CPU system
961.7 (19.9%) 14:25:16 INFO - TinderboxPrint: CPU user
1,615.1 (33.4%) 14:25:16 INFO - TinderboxPrint: Swap in / out
401,068,032 / 0 14:25:16 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356561408; Write bytes: 356837376; Read time: 27423; Write time: 753 14:25:16 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 36647936; Write bytes: 296205312; Read time: 221; Write time: 1118 14:25:16 INFO - Running post-run listener: _upload_blobber_files 14:25:16 INFO - Blob upload gear active. 14:25:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:25:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:25:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:25:16 INFO - (blobuploader) - INFO - Open directory for files ... 14:25:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:25:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:25:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:17 INFO - (blobuploader) - INFO - Done attempting. 14:25:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:25:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:25:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:18 INFO - (blobuploader) - INFO - Done attempting. 14:25:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:25:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:25:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:21 INFO - (blobuploader) - INFO - Done attempting. 14:25:21 INFO - (blobuploader) - INFO - Iteration through files over. 14:25:21 INFO - Return code: 0 14:25:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:25:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:25:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f3741801f57e6ff815eb8329e08b4496e466b6e78fa7f8e4e91fe21ac3a93196b0d709177645ea70b3a9f15abe00fa7fc6ee08d69b02647c4b77de6b7b47c13c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60a3cff99d9cab6ab6db443350795d8272659b9c8e815a870f7ffe4feb905e0a49f46b9dc5940bfd675dc936148282cb85b142ec1e0d3cd1b9baf61c2e8f8235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2785b3efd9d55bb5e17d2babae50ff1edff1d73981617ebc3beb7f113756eee4488056b383726d90886e7d26810c5589cc3ba347a7aec793cd9232f20eaafe2a"} 14:25:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:25:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:25:21 INFO - Contents: 14:25:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f3741801f57e6ff815eb8329e08b4496e466b6e78fa7f8e4e91fe21ac3a93196b0d709177645ea70b3a9f15abe00fa7fc6ee08d69b02647c4b77de6b7b47c13c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60a3cff99d9cab6ab6db443350795d8272659b9c8e815a870f7ffe4feb905e0a49f46b9dc5940bfd675dc936148282cb85b142ec1e0d3cd1b9baf61c2e8f8235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2785b3efd9d55bb5e17d2babae50ff1edff1d73981617ebc3beb7f113756eee4488056b383726d90886e7d26810c5589cc3ba347a7aec793cd9232f20eaafe2a"} 14:25:21 INFO - Running post-run listener: copy_logs_to_upload_dir 14:25:21 INFO - Copying logs to upload dir... 14:25:21 INFO - mkdir: /builds/slave/test/build/upload/logs 14:25:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.063054 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-26 14:25:21.093083) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:21.097728) ========= 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.vViDGvUUBI/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.CDOuURhEq8/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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/f3741801f57e6ff815eb8329e08b4496e466b6e78fa7f8e4e91fe21ac3a93196b0d709177645ea70b3a9f15abe00fa7fc6ee08d69b02647c4b77de6b7b47c13c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60a3cff99d9cab6ab6db443350795d8272659b9c8e815a870f7ffe4feb905e0a49f46b9dc5940bfd675dc936148282cb85b142ec1e0d3cd1b9baf61c2e8f8235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2785b3efd9d55bb5e17d2babae50ff1edff1d73981617ebc3beb7f113756eee4488056b383726d90886e7d26810c5589cc3ba347a7aec793cd9232f20eaafe2a"} 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.010968 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/f3741801f57e6ff815eb8329e08b4496e466b6e78fa7f8e4e91fe21ac3a93196b0d709177645ea70b3a9f15abe00fa7fc6ee08d69b02647c4b77de6b7b47c13c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60a3cff99d9cab6ab6db443350795d8272659b9c8e815a870f7ffe4feb905e0a49f46b9dc5940bfd675dc936148282cb85b142ec1e0d3cd1b9baf61c2e8f8235", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2785b3efd9d55bb5e17d2babae50ff1edff1d73981617ebc3beb7f113756eee4488056b383726d90886e7d26810c5589cc3ba347a7aec793cd9232f20eaafe2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:21.130787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:21.131144) ========= 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.vViDGvUUBI/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.CDOuURhEq8/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.004905 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 14:25:21.181506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:25:21.182631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 14:25:21.183385) ========= ========= Total master_lag: 0.18 =========