builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0288 starttime: 1478898547.74 results: success (0) buildid: 20161111115820 builduid: 8259f9791b2c40a1a170303b046f3a55 revision: e2c44873792bf11f8e9337a3110d94652140c962 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:07.743672) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:07.744143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:07.744423) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:07.768896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:07.769219) ========= 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.5TcEqhAY13/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.oFZOltciwK/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-11 13:09:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2016-11-11 13:09:07 (20.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:07.924458) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:07.924771) ========= 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.5TcEqhAY13/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.oFZOltciwK/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.024260 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:07.973953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-11 13:09:07.974400) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e2c44873792bf11f8e9337a3110d94652140c962 --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 e2c44873792bf11f8e9337a3110d94652140c962 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5TcEqhAY13/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.oFZOltciwK/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-11 13:09:08,060 truncating revision to first 12 chars 2016-11-11 13:09:08,060 Setting DEBUG logging. 2016-11-11 13:09:08,060 attempt 1/10 2016-11-11 13:09:08,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e2c44873792b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 13:09:08,924 unpacking tar archive at: mozilla-aurora-e2c44873792b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.143047 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-11 13:09:09.139758) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:09.140096) ========= script_repo_revision: e2c44873792bf11f8e9337a3110d94652140c962 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:09.140501) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:09.140771) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 13:09:09.159317) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-11 13:09:09.159651) ========= /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.5TcEqhAY13/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.oFZOltciwK/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:09:09 INFO - MultiFileLogger online at 20161111 13:09:09 in /builds/slave/test 13:09:09 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 13:09:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:09:09 INFO - {'append_to_log': False, 13:09:09 INFO - 'base_work_dir': '/builds/slave/test', 13:09:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:09:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:09:09 INFO - 'branch': 'Mozilla-Aurora', 13:09:09 INFO - 'buildbot_json_path': 'buildprops.json', 13:09:09 INFO - 'config_files': ('talos/mac_config.py',), 13:09:09 INFO - 'default_actions': ('clobber', 13:09:09 INFO - 'read-buildbot-config', 13:09:09 INFO - 'download-and-extract', 13:09:09 INFO - 'populate-webroot', 13:09:09 INFO - 'create-virtualenv', 13:09:09 INFO - 'install', 13:09:09 INFO - 'run-tests'), 13:09:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:09:09 INFO - 'download_minidump_stackwalk': True, 13:09:09 INFO - 'download_symbols': 'ondemand', 13:09:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:09:09 INFO - 'tooltool.py': '/tools/tooltool.py', 13:09:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:09:09 INFO - '/tools/misc-python/virtualenv.py')}, 13:09:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:09:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:09:09 INFO - 'installer_path': 'installer.exe', 13:09:09 INFO - 'log_level': 'info', 13:09:09 INFO - 'log_name': 'talos', 13:09:09 INFO - 'log_to_console': True, 13:09:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:09:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:09:09 INFO - 'opt_config_files': (), 13:09:09 INFO - 'pip_index': False, 13:09:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:09:09 INFO - 'cmd': ('bash', 13:09:09 INFO - '-c', 13:09:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:09:09 INFO - 'enabled': True, 13:09:09 INFO - 'halt_on_failure': False, 13:09:09 INFO - 'name': 'check_screen_resolution'},), 13:09:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:09:09 INFO - 'cmd': ('bash', 13:09:09 INFO - '-c', 13:09:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:09:09 INFO - 'enabled': True, 13:09:09 INFO - 'halt_on_failure': False, 13:09:09 INFO - 'name': 'check_screen_resolution'},), 13:09:09 INFO - 'run_cmd_checks_enabled': True, 13:09:09 INFO - 'sps_profile': False, 13:09:09 INFO - 'sps_profile_interval': 0, 13:09:09 INFO - 'suite': 'dromaeojs', 13:09:09 INFO - 'system_bits': '32', 13:09:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:09:09 INFO - 'title': 't-yosemite-r7-0288', 13:09:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:09:09 INFO - 'use_talos_json': True, 13:09:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:09:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:09:09 INFO - 'work_dir': 'build'} 13:09:09 INFO - [mozharness: 2016-11-11 21:09:09.362380Z] Running clobber step. 13:09:09 INFO - Running pre-action listener: _resource_record_pre_action 13:09:09 INFO - Running main action method: clobber 13:09:09 INFO - rmtree: /builds/slave/test/build 13:09:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:09:11 INFO - Running post-action listener: _resource_record_post_action 13:09:11 INFO - [mozharness: 2016-11-11 21:09:11.828457Z] Finished clobber step (success) 13:09:11 INFO - [mozharness: 2016-11-11 21:09:11.828598Z] Running read-buildbot-config step. 13:09:11 INFO - Running pre-action listener: _resource_record_pre_action 13:09:11 INFO - Running main action method: read_buildbot_config 13:09:11 INFO - Using buildbot properties: 13:09:11 INFO - { 13:09:11 INFO - "project": "", 13:09:11 INFO - "product": "firefox", 13:09:11 INFO - "script_repo_revision": "production", 13:09:11 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:09:11 INFO - "repository": "", 13:09:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:09:11 INFO - "buildid": "20161111115820", 13:09:11 INFO - "pgo_build": "False", 13:09:11 INFO - "basedir": "/builds/slave/test", 13:09:11 INFO - "buildnumber": 21, 13:09:11 INFO - "slavename": "t-yosemite-r7-0288", 13:09:11 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:09:11 INFO - "platform": "yosemite_r7", 13:09:11 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:09:11 INFO - "branch": "mozilla-aurora", 13:09:11 INFO - "repo_path": "releases/mozilla-aurora", 13:09:11 INFO - "revision": "e2c44873792bf11f8e9337a3110d94652140c962", 13:09:11 INFO - "stage_platform": "macosx64", 13:09:11 INFO - "builduid": "8259f9791b2c40a1a170303b046f3a55", 13:09:11 INFO - "slavebuilddir": "test" 13:09:11 INFO - } 13:09:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 13:09:11 INFO - Running post-action listener: _resource_record_post_action 13:09:11 INFO - [mozharness: 2016-11-11 21:09:11.831825Z] Finished read-buildbot-config step (success) 13:09:11 INFO - [mozharness: 2016-11-11 21:09:11.831960Z] Running download-and-extract step. 13:09:11 INFO - Running pre-action listener: _resource_record_pre_action 13:09:11 INFO - Running main action method: download_and_extract 13:09:11 INFO - mkdir: /builds/slave/test/build/tests 13:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:11 INFO - trying https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 13:09:11 INFO - Downloading https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/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 13:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/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 13:09:12 INFO - Downloaded 1199 bytes. 13:09:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 13:09:12 INFO - Using the following test package requirements: 13:09:12 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 13:09:12 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:09:12 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 13:09:12 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:09:12 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 13:09:12 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:09:12 INFO - u'jsshell-mac.zip'], 13:09:12 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:09:12 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 13:09:12 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 13:09:12 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:09:12 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 13:09:12 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:09:12 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 13:09:12 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:09:12 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 13:09:12 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:09:12 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 13:09:12 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:09:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 13:09:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:09:12 INFO - Fetch https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 13:09:13 INFO - Expected file size: 16423739 13:09:20 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 13:09:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 13:09:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:09:20 INFO - Fetch https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 13:09:20 INFO - Expected file size: 16423739 13:09:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 13:09:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:09:27 INFO - Fetch https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 13:09:28 INFO - Expected file size: 14414089 13:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:29 INFO - trying https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:09:29 INFO - Downloading https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 13:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/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 13:09:32 INFO - Downloaded 115558559 bytes. 13:09:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:09:32 INFO - mkdir: /builds/slave/test/properties 13:09:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:09:32 INFO - Writing to file /builds/slave/test/properties/build_url 13:09:32 INFO - Contents: 13:09:32 INFO - build_url:https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:09:32 INFO - Running post-action listener: _resource_record_post_action 13:09:32 INFO - Running post-action listener: set_extra_try_arguments 13:09:32 INFO - [mozharness: 2016-11-11 21:09:32.982906Z] Finished download-and-extract step (success) 13:09:32 INFO - [mozharness: 2016-11-11 21:09:32.983038Z] Running populate-webroot step. 13:09:32 INFO - Running pre-action listener: _resource_record_pre_action 13:09:32 INFO - Running main action method: populate_webroot 13:09:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:09:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:09:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:09:32 INFO - '--tppagecycles', 13:09:32 INFO - '7'], 13:09:32 INFO - 'tests': ['tsvgm']}}, 13:09:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:09:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:09:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:09:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:09:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:09:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:09:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:32 INFO - 'talos_options': ['--disable-e10s'], 13:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:32 INFO - 'talos_options': ['--disable-e10s'], 13:09:32 INFO - 'tests': ['damp', 'tps']}, 13:09:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:32 INFO - 'tests': ['damp', 'tps']}, 13:09:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:09:32 INFO - 'tests': ['dromaeo_dom']}, 13:09:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:09:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:09:32 INFO - 'tests': ['basic_compositor_video']}, 13:09:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:09:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:09:32 INFO - 'tests': ['a11yr', 13:09:32 INFO - 'ts_paint', 13:09:32 INFO - 'tpaint', 13:09:32 INFO - 'sessionrestore', 13:09:32 INFO - 'sessionrestore_no_auto_restore', 13:09:32 INFO - 'tabpaint']}, 13:09:32 INFO - 'other-e10s': {'tests': ['a11yr', 13:09:32 INFO - 'ts_paint', 13:09:32 INFO - 'tpaint', 13:09:32 INFO - 'sessionrestore', 13:09:32 INFO - 'sessionrestore_no_auto_restore', 13:09:32 INFO - 'tabpaint']}, 13:09:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:09:32 INFO - 'ts_paint', 13:09:32 INFO - 'tpaint', 13:09:32 INFO - 'sessionrestore', 13:09:32 INFO - 'sessionrestore_no_auto_restore', 13:09:32 INFO - 'tabpaint']}, 13:09:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:09:32 INFO - 'ts_paint', 13:09:32 INFO - 'tpaint', 13:09:32 INFO - 'sessionrestore', 13:09:32 INFO - 'sessionrestore_no_auto_restore', 13:09:32 INFO - 'tabpaint']}, 13:09:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:09:32 INFO - 'tests': ['a11yr', 13:09:32 INFO - 'ts_paint', 13:09:32 INFO - 'tpaint', 13:09:32 INFO - 'sessionrestore', 13:09:32 INFO - 'sessionrestore_no_auto_restore', 13:09:32 INFO - 'tabpaint']}, 13:09:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:09:32 INFO - 'tests': ['a11yr', 13:09:32 INFO - 'ts_paint', 13:09:32 INFO - 'tpaint', 13:09:32 INFO - 'sessionrestore', 13:09:32 INFO - 'sessionrestore_no_auto_restore', 13:09:32 INFO - 'tabpaint']}, 13:09:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:09:32 INFO - 'tests': ['tsvgx', 13:09:32 INFO - 'tsvgr_opacity', 13:09:32 INFO - 'tart', 13:09:32 INFO - 'tscrollx', 13:09:32 INFO - 'cart']}, 13:09:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:09:32 INFO - 'tsvgr_opacity', 13:09:32 INFO - 'tart', 13:09:32 INFO - 'tscrollx', 13:09:32 INFO - 'cart']}, 13:09:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:32 INFO - 'talos_options': ['--disable-e10s'], 13:09:33 INFO - 'tests': ['tp5o']}, 13:09:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:33 INFO - 'tests': ['tp5o']}, 13:09:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:33 INFO - 'talos_options': ['--disable-e10s', 13:09:33 INFO - '--xperf_path', 13:09:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:33 INFO - 'tests': ['tp5n']}, 13:09:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:33 INFO - 'talos_options': ['--xperf_path', 13:09:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:33 INFO - 'tests': ['tp5n']}}, 13:09:33 INFO - 'talos.zip': {'path': '', 13:09:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:09:33 INFO - Running post-action listener: _resource_record_post_action 13:09:33 INFO - [mozharness: 2016-11-11 21:09:33.001670Z] Finished populate-webroot step (success) 13:09:33 INFO - [mozharness: 2016-11-11 21:09:33.001801Z] Running create-virtualenv step. 13:09:33 INFO - Running pre-action listener: _resource_record_pre_action 13:09:33 INFO - Running main action method: create_virtualenv 13:09:33 INFO - Creating virtualenv /builds/slave/test/build/venv 13:09:33 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 13:09:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:09:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:09:33 INFO - Using real prefix '/tools/python27' 13:09:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:09:33 INFO - Installing distribute.............................................................................................................................................................................................done. 13:09:36 INFO - Installing pip.................done. 13:09:36 INFO - Return code: 0 13:09:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:36 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 0x102d67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad51cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, '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.5TcEqhAY13/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.oFZOltciwK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:09:36 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 13:09:36 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 13:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:36 INFO - 'HOME': '/Users/cltbld', 13:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:36 INFO - 'LOGNAME': 'cltbld', 13:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:36 INFO - 'MOZ_NO_REMOTE': '1', 13:09:36 INFO - 'NO_EM_RESTART': '1', 13:09:36 INFO - 'PAGER': '/bin/cat', 13:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:36 INFO - 'PWD': '/builds/slave/test', 13:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:36 INFO - 'SHELL': '/bin/bash', 13:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:09:36 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:36 INFO - 'USER': 'cltbld', 13:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:36 INFO - 'XPC_FLAGS': '0x0', 13:09:36 INFO - 'XPC_SERVICE_NAME': '0', 13:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:36 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 13:09:36 INFO - Cleaning up... 13:09:36 INFO - Return code: 0 13:09:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:36 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 0x102d67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad51cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, '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.5TcEqhAY13/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.oFZOltciwK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:09:36 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 13:09:36 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 13:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:36 INFO - 'HOME': '/Users/cltbld', 13:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:36 INFO - 'LOGNAME': 'cltbld', 13:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:36 INFO - 'MOZ_NO_REMOTE': '1', 13:09:36 INFO - 'NO_EM_RESTART': '1', 13:09:36 INFO - 'PAGER': '/bin/cat', 13:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:36 INFO - 'PWD': '/builds/slave/test', 13:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:36 INFO - 'SHELL': '/bin/bash', 13:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:09:36 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:36 INFO - 'USER': 'cltbld', 13:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:36 INFO - 'XPC_FLAGS': '0x0', 13:09:36 INFO - 'XPC_SERVICE_NAME': '0', 13:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:37 INFO - Downloading/unpacking psutil>=3.1.1 13:09:37 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 13:09:37 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 13:09:37 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 13:09:37 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 13:09:37 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 13:09:37 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 13:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:40 INFO - Installing collected packages: psutil 13:09:40 INFO - Running setup.py install for psutil 13:09:40 INFO - building 'psutil._psutil_osx' extension 13:09:40 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 13:09:40 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 13:09:40 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 13:09:41 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 13:09:41 INFO - building 'psutil._psutil_posix' extension 13:09:41 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 13:09:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:09:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:09:41 INFO - ^ 13:09:41 INFO - 1 warning generated. 13:09:41 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 13:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:41 INFO - Successfully installed psutil 13:09:41 INFO - Cleaning up... 13:09:41 INFO - Return code: 0 13:09:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:09:41 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')]} 13:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:41 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')]} 13:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:41 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 0x102d67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad51cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, '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.5TcEqhAY13/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.oFZOltciwK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:09:41 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 13:09:41 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 13:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:41 INFO - 'HOME': '/Users/cltbld', 13:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:41 INFO - 'LOGNAME': 'cltbld', 13:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:41 INFO - 'MOZ_NO_REMOTE': '1', 13:09:41 INFO - 'NO_EM_RESTART': '1', 13:09:41 INFO - 'PAGER': '/bin/cat', 13:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:41 INFO - 'PWD': '/builds/slave/test', 13:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:41 INFO - 'SHELL': '/bin/bash', 13:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:09:41 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:41 INFO - 'USER': 'cltbld', 13:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:41 INFO - 'XPC_FLAGS': '0x0', 13:09:41 INFO - 'XPC_SERVICE_NAME': '0', 13:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:09:41 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 13:09:41 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 13:09:41 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 13:09:41 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 13:09:41 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 13:09:41 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 13:09:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:09:44 INFO - Installing collected packages: mozsystemmonitor 13:09:44 INFO - Running setup.py install for mozsystemmonitor 13:09:44 INFO - Successfully installed mozsystemmonitor 13:09:44 INFO - Cleaning up... 13:09:44 INFO - Return code: 0 13:09:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:09:44 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')]} 13:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:44 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')]} 13:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:44 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 0x102d67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad51cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, '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.5TcEqhAY13/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.oFZOltciwK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:09:44 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 13:09:44 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 13:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:44 INFO - 'HOME': '/Users/cltbld', 13:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:44 INFO - 'LOGNAME': 'cltbld', 13:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:44 INFO - 'MOZ_NO_REMOTE': '1', 13:09:44 INFO - 'NO_EM_RESTART': '1', 13:09:44 INFO - 'PAGER': '/bin/cat', 13:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:44 INFO - 'PWD': '/builds/slave/test', 13:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:44 INFO - 'SHELL': '/bin/bash', 13:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:09:44 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:44 INFO - 'USER': 'cltbld', 13:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:44 INFO - 'XPC_FLAGS': '0x0', 13:09:44 INFO - 'XPC_SERVICE_NAME': '0', 13:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:44 INFO - Downloading/unpacking jsonschema==2.5.1 13:09:44 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 13:09:44 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 13:09:44 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 13:09:44 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 13:09:44 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 13:09:44 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 13:09:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:09:47 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 13:09:47 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 13:09:47 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 13:09:47 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 13:09:47 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 13:09:47 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 13:09:47 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:47 INFO - warning: no files found matching '*.txt' 13:09:47 INFO - no previously-included directories found matching 'build' 13:09:47 INFO - no previously-included directories found matching 'dist' 13:09:47 INFO - no previously-included directories found matching '.git*' 13:09:47 INFO - Installing collected packages: jsonschema, functools32 13:09:47 INFO - Running setup.py install for functools32 13:09:48 INFO - warning: no files found matching '*.txt' 13:09:48 INFO - no previously-included directories found matching 'build' 13:09:48 INFO - no previously-included directories found matching 'dist' 13:09:48 INFO - no previously-included directories found matching '.git*' 13:09:48 INFO - Successfully installed jsonschema functools32 13:09:48 INFO - Cleaning up... 13:09:48 INFO - Return code: 0 13:09:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:09:48 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')]} 13:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 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')]} 13:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 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 0x102d67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad51cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, '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.5TcEqhAY13/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.oFZOltciwK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:09:48 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 13:09:48 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 13:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:48 INFO - 'HOME': '/Users/cltbld', 13:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:48 INFO - 'LOGNAME': 'cltbld', 13:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:48 INFO - 'MOZ_NO_REMOTE': '1', 13:09:48 INFO - 'NO_EM_RESTART': '1', 13:09:48 INFO - 'PAGER': '/bin/cat', 13:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:48 INFO - 'PWD': '/builds/slave/test', 13:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:48 INFO - 'SHELL': '/bin/bash', 13:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:09:48 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:48 INFO - 'USER': 'cltbld', 13:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:48 INFO - 'XPC_FLAGS': '0x0', 13:09:48 INFO - 'XPC_SERVICE_NAME': '0', 13:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:09:48 INFO - Cleaning up... 13:09:48 INFO - Return code: 0 13:09:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:09:48 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')]} 13:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 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')]} 13:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 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 0x102d67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad51cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, '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.5TcEqhAY13/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.oFZOltciwK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:09:48 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 13:09:48 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 13:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:48 INFO - 'HOME': '/Users/cltbld', 13:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:48 INFO - 'LOGNAME': 'cltbld', 13:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:48 INFO - 'MOZ_NO_REMOTE': '1', 13:09:48 INFO - 'NO_EM_RESTART': '1', 13:09:48 INFO - 'PAGER': '/bin/cat', 13:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:48 INFO - 'PWD': '/builds/slave/test', 13:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:48 INFO - 'SHELL': '/bin/bash', 13:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:09:48 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:48 INFO - 'USER': 'cltbld', 13:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:48 INFO - 'XPC_FLAGS': '0x0', 13:09:48 INFO - 'XPC_SERVICE_NAME': '0', 13:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:09:48 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 13:09:48 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 13:09:48 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 13:09:48 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 13:09:48 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 13:09:48 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 13:09:51 INFO - Downloading blobuploader-1.2.4.tar.gz 13:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:52 INFO - Downloading docopt-0.6.1.tar.gz 13:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:52 INFO - Running setup.py install for blobuploader 13:09:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:52 INFO - Running setup.py install for requests 13:09:53 INFO - Running setup.py install for docopt 13:09:53 INFO - Successfully installed blobuploader requests docopt 13:09:53 INFO - Cleaning up... 13:09:53 INFO - Return code: 0 13:09:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:53 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 0x102d67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad51cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, '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.5TcEqhAY13/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.oFZOltciwK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:09:53 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 13:09:53 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 13:09:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:09:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:53 INFO - 'HOME': '/Users/cltbld', 13:09:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:53 INFO - 'LOGNAME': 'cltbld', 13:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:53 INFO - 'MOZ_NO_REMOTE': '1', 13:09:53 INFO - 'NO_EM_RESTART': '1', 13:09:53 INFO - 'PAGER': '/bin/cat', 13:09:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:53 INFO - 'PWD': '/builds/slave/test', 13:09:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:53 INFO - 'SHELL': '/bin/bash', 13:09:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:09:53 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:09:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:53 INFO - 'USER': 'cltbld', 13:09:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:53 INFO - 'XPC_FLAGS': '0x0', 13:09:53 INFO - 'XPC_SERVICE_NAME': '0', 13:09:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:53 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-dKqEIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:53 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-cBdOnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:53 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-EOdFPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:53 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-6SEPmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:54 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-dbPfWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:54 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Q356pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:54 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-JEmAgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:54 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-UfUt0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:54 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-g6CA0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:54 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-YOTcya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:54 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-lOb04Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:54 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-dUI2b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:54 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-_1BkDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:54 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-8xSiKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:55 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-f8nmDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:55 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-3O5nQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:55 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-bF_SQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:09:55 INFO - Running setup.py install for manifestparser 13:09:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:09:55 INFO - Running setup.py install for mozcrash 13:09:55 INFO - Running setup.py install for mozdebug 13:09:55 INFO - Running setup.py install for mozdevice 13:09:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:09:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:09:55 INFO - Running setup.py install for mozfile 13:09:56 INFO - Running setup.py install for mozhttpd 13:09:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Running setup.py install for mozinfo 13:09:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Running setup.py install for mozInstall 13:09:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Running setup.py install for mozleak 13:09:56 INFO - Running setup.py install for mozlog 13:09:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Running setup.py install for moznetwork 13:09:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Running setup.py install for mozprocess 13:09:57 INFO - Running setup.py install for mozprofile 13:09:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Running setup.py install for mozrunner 13:09:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Running setup.py install for mozscreenshot 13:09:57 INFO - Running setup.py install for moztest 13:09:57 INFO - Running setup.py install for mozversion 13:09:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:09:57 INFO - Cleaning up... 13:09:57 INFO - Return code: 0 13:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:57 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')]} 13:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:57 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')]} 13:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:57 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 0x102d67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad51cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, '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.5TcEqhAY13/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.oFZOltciwK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:09:57 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 13:09:57 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 13:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:57 INFO - 'HOME': '/Users/cltbld', 13:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:57 INFO - 'LOGNAME': 'cltbld', 13:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:57 INFO - 'MOZ_NO_REMOTE': '1', 13:09:57 INFO - 'NO_EM_RESTART': '1', 13:09:57 INFO - 'PAGER': '/bin/cat', 13:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:57 INFO - 'PWD': '/builds/slave/test', 13:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:57 INFO - 'SHELL': '/bin/bash', 13:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:09:57 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:57 INFO - 'USER': 'cltbld', 13:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:57 INFO - 'XPC_FLAGS': '0x0', 13:09:57 INFO - 'XPC_SERVICE_NAME': '0', 13:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:58 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-bD7yn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:58 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)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:58 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-DewL9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:58 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)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:58 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-5LyntZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:58 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)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:58 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-TtbNSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:58 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)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:58 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Y23oNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:58 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)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:58 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-S8vXUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:58 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)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:58 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Uwn_4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:58 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)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:58 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-GsYfZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:59 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)) 13:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:59 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-OvI5iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:59 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)) 13:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:59 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-yB3WKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:59 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)) 13:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:59 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-yofSVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:59 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)) 13:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:59 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Fd8joV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:59 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)) 13:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:59 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Ik6Ore-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:59 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)) 13:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:59 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-jzpCXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:59 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)) 13:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:59 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-du9Gdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:59 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)) 13:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:59 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-0fZc_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:59 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)) 13:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:59 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-yxlFRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:10:00 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)) 13:10:00 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)) 13:10:00 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)) 13:10:00 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)) 13:10:00 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)) 13:10:00 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)) 13:10:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:10:00 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 13:10:00 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 13:10:00 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 13:10:00 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 13:10:00 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 13:10:00 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 13:10:02 INFO - Downloading blessings-1.6.tar.gz 13:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:10:02 INFO - Installing collected packages: blessings 13:10:02 INFO - Running setup.py install for blessings 13:10:02 INFO - Successfully installed blessings 13:10:02 INFO - Cleaning up... 13:10:02 INFO - Return code: 0 13:10:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:03 INFO - Reading from file tmpfile_stdout 13:10:03 INFO - Current package versions: 13:10:03 INFO - blessings == 1.6 13:10:03 INFO - blobuploader == 1.2.4 13:10:03 INFO - docopt == 0.6.1 13:10:03 INFO - functools32 == 3.2.3-2 13:10:03 INFO - jsonschema == 2.5.1 13:10:03 INFO - manifestparser == 1.1 13:10:03 INFO - mozInstall == 1.12 13:10:03 INFO - mozcrash == 0.17 13:10:03 INFO - mozdebug == 0.1 13:10:03 INFO - mozdevice == 0.48 13:10:03 INFO - mozfile == 1.2 13:10:03 INFO - mozhttpd == 0.7 13:10:03 INFO - mozinfo == 0.9 13:10:03 INFO - mozleak == 0.1 13:10:03 INFO - mozlog == 3.4 13:10:03 INFO - moznetwork == 0.27 13:10:03 INFO - mozprocess == 0.23 13:10:03 INFO - mozprofile == 0.28 13:10:03 INFO - mozrunner == 6.12 13:10:03 INFO - mozscreenshot == 0.1 13:10:03 INFO - mozsystemmonitor == 0.3 13:10:03 INFO - moztest == 0.7 13:10:03 INFO - mozversion == 1.4 13:10:03 INFO - psutil == 3.1.1 13:10:03 INFO - requests == 1.2.3 13:10:03 INFO - wsgiref == 0.1.2 13:10:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:03 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')]} 13:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:03 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')]} 13:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:03 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 0x102d67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad51cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, '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.5TcEqhAY13/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.oFZOltciwK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:10:03 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 13:10:03 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 13:10:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:10:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:03 INFO - 'HOME': '/Users/cltbld', 13:10:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:03 INFO - 'LOGNAME': 'cltbld', 13:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:03 INFO - 'MOZ_NO_REMOTE': '1', 13:10:03 INFO - 'NO_EM_RESTART': '1', 13:10:03 INFO - 'PAGER': '/bin/cat', 13:10:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:03 INFO - 'PWD': '/builds/slave/test', 13:10:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:03 INFO - 'SHELL': '/bin/bash', 13:10:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:10:03 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:10:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:03 INFO - 'USER': 'cltbld', 13:10:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:03 INFO - 'XPC_FLAGS': '0x0', 13:10:03 INFO - 'XPC_SERVICE_NAME': '0', 13:10:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:03 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)) 13:10:03 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)) 13:10:03 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)) 13:10:03 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)) 13:10:03 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)) 13:10:03 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)) 13:10:03 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)) 13:10:03 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)) 13:10:03 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)) 13:10:03 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)) 13:10:03 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)) 13:10:03 INFO - Cleaning up... 13:10:03 INFO - Return code: 0 13:10:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:10:03 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')]} 13:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:03 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')]} 13:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:03 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 0x102d67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95bad51cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, '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.5TcEqhAY13/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.oFZOltciwK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 13:10:03 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 13:10:03 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 13:10:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:10:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:03 INFO - 'HOME': '/Users/cltbld', 13:10:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:03 INFO - 'LOGNAME': 'cltbld', 13:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:03 INFO - 'MOZ_NO_REMOTE': '1', 13:10:03 INFO - 'NO_EM_RESTART': '1', 13:10:03 INFO - 'PAGER': '/bin/cat', 13:10:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:03 INFO - 'PWD': '/builds/slave/test', 13:10:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:03 INFO - 'SHELL': '/bin/bash', 13:10:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:10:03 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:10:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:03 INFO - 'USER': 'cltbld', 13:10:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:03 INFO - 'XPC_FLAGS': '0x0', 13:10:03 INFO - 'XPC_SERVICE_NAME': '0', 13:10:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:10:03 INFO - Cleaning up... 13:10:03 INFO - Return code: 0 13:10:03 INFO - Running post-action listener: _resource_record_post_action 13:10:03 INFO - Running post-action listener: _start_resource_monitoring 13:10:03 INFO - Starting resource monitoring. 13:10:03 INFO - [mozharness: 2016-11-11 21:10:03.695414Z] Finished create-virtualenv step (success) 13:10:03 INFO - [mozharness: 2016-11-11 21:10:03.696464Z] Running install step. 13:10:03 INFO - Running pre-action listener: _resource_record_pre_action 13:10:03 INFO - Running main action method: install 13:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:03 INFO - Reading from file tmpfile_stdout 13:10:03 INFO - Detecting whether we're running mozinstall >=1.0... 13:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:10:04 INFO - Reading from file tmpfile_stdout 13:10:04 INFO - Output received: 13:10:04 INFO - Usage: mozinstall [options] installer 13:10:04 INFO - Options: 13:10:04 INFO - -h, --help show this help message and exit 13:10:04 INFO - -d DEST, --destination=DEST 13:10:04 INFO - Directory to install application into. [default: 13:10:04 INFO - "/builds/slave/test"] 13:10:04 INFO - --app=APP Application being installed. [default: firefox] 13:10:04 INFO - mkdir: /builds/slave/test/build/application 13:10:04 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'] 13:10:04 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 13:10:36 INFO - Reading from file tmpfile_stdout 13:10:36 INFO - Output received: 13:10:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:10:36 INFO - Running post-action listener: _resource_record_post_action 13:10:36 INFO - [mozharness: 2016-11-11 21:10:36.546073Z] Finished install step (success) 13:10:36 INFO - [mozharness: 2016-11-11 21:10:36.546231Z] Running run-tests step. 13:10:36 INFO - Running pre-action listener: _resource_record_pre_action 13:10:36 INFO - Running main action method: run_tests 13:10:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:10:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:10:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:10:36 INFO - 2016-11-11 13:10:36.560 screenresolution[1635:7443] starting screenresolution argv=screenresolution get 13:10:36 INFO - 2016-11-11 13:10:36.563 screenresolution[1635:7443] Display 0: 1600x1200x32@60 13:10:36 INFO - 2016-11-11 13:10:36.568 screenresolution[1636:7446] starting screenresolution argv=screenresolution list 13:10:36 INFO - Available Modes on Display 0 13:10:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:10:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:10:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:10:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:10:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:10:36 INFO - Intel Iris: 13:10:36 INFO - Chipset Model: Intel Iris 13:10:36 INFO - Type: GPU 13:10:36 INFO - Bus: Built-In 13:10:36 INFO - VRAM (Dynamic, Max): 1536 MB 13:10:36 INFO - Vendor: Intel (0x8086) 13:10:36 INFO - Device ID: 0x0a2e 13:10:36 INFO - Revision ID: 0x0009 13:10:36 INFO - Displays: 13:10:36 INFO - Display: 13:10:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:10:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:10:36 INFO - Display Serial Number: 1600x1200 60 13:10:36 INFO - Main Display: Yes 13:10:36 INFO - Mirror: Off 13:10:36 INFO - Online: Yes 13:10:36 INFO - Rotation: Supported 13:10:36 INFO - Return code: 0 13:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:10:36 INFO - Python 2.7.3 13:10:36 INFO - Return code: 0 13:10:36 INFO - grabbing minidump binary from tooltool 13:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:36 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 0x102b7bd30>, '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 0x1029e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102b73b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:10:36 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 13:10:36 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 13:10:36 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 13:10:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:10:36 INFO - Return code: 0 13:10:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:10:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:10:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:10:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:10:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:10:36 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/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--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 13:10:36 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/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0288 --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 13:10:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5TcEqhAY13/Render', 13:10:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:36 INFO - 'HOME': '/Users/cltbld', 13:10:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:36 INFO - 'LOGNAME': 'cltbld', 13:10:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:36 INFO - 'MOZ_NO_REMOTE': '1', 13:10:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:36 INFO - 'NO_EM_RESTART': '1', 13:10:36 INFO - 'PAGER': '/bin/cat', 13:10:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:36 INFO - 'PWD': '/builds/slave/test', 13:10:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:36 INFO - 'SHELL': '/bin/bash', 13:10:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oFZOltciwK/Listeners', 13:10:36 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 13:10:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:36 INFO - 'USER': 'cltbld', 13:10:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:36 INFO - 'XPC_FLAGS': '0x0', 13:10:36 INFO - 'XPC_SERVICE_NAME': '0', 13:10:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:36 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/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--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 13:10:37 INFO - mozversion application_buildid: 20161111115820 13:10:37 INFO - mozversion application_changeset: e2c44873792bf11f8e9337a3110d94652140c962 13:10:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:10:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:10:37 INFO - mozversion application_name: Firefox 13:10:37 INFO - mozversion application_remotingname: firefox-dev 13:10:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:10:37 INFO - mozversion application_vendor: Mozilla 13:10:37 INFO - mozversion application_version: 51.0a2 13:10:37 INFO - mozversion platform_buildid: 20161111115820 13:10:37 INFO - mozversion platform_changeset: e2c44873792bf11f8e9337a3110d94652140c962 13:10:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:10:37 INFO - mozversion platform_version: 51.0a2 13:10:37 INFO - using testdate: 1478898637 13:10:37 INFO - actual date: 1478898637 13:10:37 INFO - starting webserver on 'localhost:49276' 13:10:37 INFO - SUITE-START | Running 2 tests 13:10:37 INFO - TEST-START | dromaeo_css 13:10:37 INFO - operating with platform_type : mac_ 13:10:37 INFO - Initialising browser for dromaeo_css test... 13:10:37 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpPvDAcw/profile http://localhost:49276/getInfo.html) 13:10:39 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 13:10:39 INFO - PROCESS | 1646 | colorDepth:24 13:10:39 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 13:10:39 INFO - PROCESS | 1646 | __metrics 13:10:39 INFO - PROCESS | 1646 | 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" 13:10:39 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:10:40 INFO - TEST-INFO | 1646: exit 0 13:10:40 INFO - Browser initialized. 13:10:40 INFO - Running cycle 1/1 for dromaeo_css test... 13:10:40 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpPvDAcw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:52 INFO - PROCESS | 1648 | RSS: Main: 220450816 13:10:52 INFO - PROCESS | 1648 | 13:11:43 INFO - PROCESS | 1648 | 1478898703725 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] 13:13:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 13:13:57 INFO - PROCESS | 1648 | RSS: Main: 370057216 13:13:57 INFO - PROCESS | 1648 | 13:17:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 13:17:01 INFO - PROCESS | 1648 | RSS: Main: 354533376 13:17:01 INFO - PROCESS | 1648 | 13:20:03 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 13:20:03 INFO - PROCESS | 1648 | RSS: Main: 322691072 13:20:03 INFO - PROCESS | 1648 | 13:23:06 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 13:23:06 INFO - PROCESS | 1648 | RSS: Main: 327811072 13:23:06 INFO - PROCESS | 1648 | 13:26:10 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 13:26:10 INFO - PROCESS | 1648 | RSS: Main: 312651776 13:26:10 INFO - PROCESS | 1648 | 13:29:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 13:29:14 INFO - PROCESS | 1648 | RSS: Main: 437411840 13:29:14 INFO - PROCESS | 1648 | 13:29:14 INFO - PROCESS | 1648 | __start_tp_report 13:29:14 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 13:29:14 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 13:29:14 INFO - PROCESS | 1648 | |i|pagename|runs| 13:29:14 INFO - PROCESS | 1648 | |0;dojo.html;2826.420583780325;3347.9497807532885;3396.184915620252;3411.471221960597;3424.606170290416;5716.28546431696;5754.108113242454;5765.279340082489;5771.076627739562;5792.710364481775;5705.286839145107;5796.768129274824;5815;5817.301923769143;5819.912701309484;5221.634485586011;5271.314729085214;5292.391374991867;5297.337832770903;5340.305760251162;5228.660137091096;5232.895342093156;5357.946420535804;5377.7580008899495;5377.8117765878205;5279.577633789288;5282.973585132069;5304.310439642841;5322.4411436799155;5323.547498462616;4392.16548855718;5300.655457395257;5309.52214300711;5343.652662576959;5365.3293338332705;5221.269022336875;5279.947200528022;5304.071787437221;5308.973455132738;5353.892922141536;5642.294713160855;5700.144978253254;5719.571032172562;5737.913931291034;5750.913736293959;5416.729163541847;6186.597871138361;6249.625022498664;6262.561620686553;6274.811755647338;5453.481919217668;6174.073888916653;6187.81436556904;6232.25212974446;6275.184226050585;5658.943410565924;5665.036943719495;5691.943080569141;5870.236869207061;5917.437843404869;6182.505399568024;6207.099970504251;6219.533534984895;6293.590916590407;6297.023961286008;6181.629102253879;6213.596116252519;6213.627182369072;6218.81343559694;6225.968870155621;6116.33577150815;6164.229471316085;6274.592151510137;6299.464545513591;6307.590006649553;5234.502722241381;6176.81469555914;6212.099245609452;6284.12022316876;6296.685165741695;6211.627302361872;6249.187605611241;6278.905816412757;6296.118543403927;6297.338779428185;4819.373481447389;4952.801887924515;4975.502449755068;4981.153203955337;5000.39995200571;4408.338749187647;4425.048614547888;4461.531539188403;4463.419755431838;4487.304467807495;5951.047832346891;5959.672218027963;5961;5961.493273071751;5964.522838172936;6220.409061139185;6238.812835614939;6246.843828904313;6262.12330273762;6262.1859158310035;5732.6847023413275;5743;5801.970990145022;5885.47030767233;5923;5428.45715428454;5439.5376393006245;5466.125419932791;5466.781328746885;5482.616216864782;6321.652309123042;6327.873442531216;6329.936700632935;6347.39699728525;6353.3011368748475;6200.844978875564;6200.852842224203;6272.8118156455375;6291.528135389955;6291.842703932438;6211.472024877755;6233.532485063548;6236.688165591793;6255.24937007562;6320.5575609706875;6201.782937597343;6222.782202623068;6239.251289845248;6244.843878902882;6245.9069662807915;6175.505959523138;6214.098955651496;6258;6279.71741271653;6280.5289603279025;4871.9269210962575;6032.698365081641;6122.39815511198;6130.846728831815;6152.907706384318;6197.380261973947;6212.968935155295;6221.440070393686;6231.345708700521;6236.937630623817;5887.260755092021;6079.392060793885;6088.150830315894;6092.9882830978195;6095.786647467317;6089.391060893875;6139.9079013813935;6140.17107690456;6142.04798256271;6221.595596286227;5980.850478738066;6053.818385448443;6058.818235452944;6072.666003369857;6085.604435711664 13:29:14 INFO - PROCESS | 1648 | |1;ext.html;490.8944576915965;522.6628824408257;526.4682670502791;530.0750190916849;534.6337758635335;25240.242792716203;40721.59278407215;41659.375109373344;41731;41748.37377439341;43001.784991075;43458;43460;43494.56505434945;43612.56387436124;9857.063578960006;10051.346662466953;10062.345947513424;10063;10064.899351006507;7690.692372305129;9027.458352498837;12003.939980300087;12334.876651233508;12356.814647780291;12187.512499500053;12257.26456412618;12262.632121036339;12282.508699652004;12286.447109880077;8775.956120219358;12206.328651924141;12283.385830708428;12296.139270251086;12301.753964920741;8746.34402419821;11804.52781888732;12099.274043557414;12120.45457954394;12320.81518777219;41046.79476602598;41313.58686413128;41325.380119298236;41350.79324603388;41365.58634413647;3336.4661654135466;3366.6801653842845;3389.237421580149;3600.819959002066;3606.945895811565;29188.708112918812;30293.697063029307;30415.695843041507;31094;31750.888718894726;3160.336329370812;3300.290437555937;3337.8331083445732;3381.5944078226685;3405.0465869556565;375618.1219093914;375628;376944;377004;377813;61501.69249153726;61510.077348839804;61713;61835.07247391293;61856.69071654613;65061.349386506474;65094.349056509775;65137;65145.67427162929;65359.019614705816;16940.40708575194;17166.742498862528;17193.828061719472;17208.741868871977;17211.483655490356;11957.402129893471;12103.031757459383;13121.212727236396;13224.669383265304;13230.272335021666;15353.923230383776;17121.315147393965;17497.650046998988;17511.64976700459;17919.283228670967;6539.50953678476;6580.5722628029025;6625.3043430440075;6632.767853125118;6637.668116594151;890.6214858685033;1025.738436698637;1086.723100357093;1092.9344239345664;1112.866456025266;28727.712722872922;29222.977195798045;29954.400911982073;30490.847545762572;30569.23576910595;1113.8050841102774;1125.234840308598;1141.149843366697;1154.5670373609896;1174.929504229749;15388.38446462129;15525.689486210213;15629.68740625181;15669.60825979337;16036.839631603534;681868;688734;688856;688949;695190;50364.740881477526;51156.744216279425;51402.97194056173;58721.70639146777;59558.10662840061;1347.2320777157122;1377.5591810620706;1394.5188909826093;1396.5670642100981;1399.0556374447208;24794.752052479245;30432.543511847784;31748.841255793574;31910.84044579762;32525.67474325321;51566.22650660168;51876.221856672935;51948;51981.22028169656;51982.70043248949;653447.7327613331;658072;665172;847353;848742;25618.35954101088;25753.484930300914;25980.22059338223;26044;26119.085831995788;46446.30330544977;46783.76608116938;46878.29682554696;47204.05591888211;47366.76316618395;38442.80778596089;38742.418863717634;39506.40740388839;39513;40803.59196407998;38938.6106138935;39531;39662.008449788984;40197.59802401938;40495.59504404918;38016.809915950245;38101.809490952364;38430.84707458781;38917.02707432337;39211.80394098011;33505.162370940925;34765.826170869994;35031.89808611492;35358.408871600324;35475.11312217215;22443;25728.61407078933;26021.219363419128;26021.219363419128;26157.60763588586 13:29:14 INFO - PROCESS | 1648 | |2;jquery.html;351.4938488576448;369.65806628868296;372.895589235014;382.22027064787824;400.8556919508976;15208.239588020597;15236.847631523682;16691.83308166918;20793.792062079374;21041.368758937217;19292.421227363167;19777.50556236091;20150.294739684115;20444.28445004425;20591.897040514777;4775.331453596499;5967.8209653710455;6210.596311239755;6211.596246244002;6215.81352559424;5280.392754833186;6147.477464415508;6149.13912052313;6183.319834818189;6188.350223226564;5865.794697185599;6056.818295451144;6141.631502109865;6141.815745527641;6151.077338399231;6050.969745151268;6061.333253342129;6101.725422355982;6103.938960610403;6110.3889611038985;5228.5555727763185;5275.050490911634;5468.26178465906;5505.311836020497;5586.385497595261;12725.42735576892;12969.092163548556;12984;20851.687224691643;25287.241382758548;2174.824337272425;2304.686328792589;2614.686237651494;2653.2703506535663;2932.1643331650375;10131.696049118538;10297.485125743759;13761.862381376159;14501.274936253145;15010.774838377432;1816.909154542281;1823.4298795660318;1830.5698160932304;1861.5067007243092;1868.785089714673;121824;123475.38262308721;126528.36735816354;127791;130894;9819.852702209473;11236.494357753922;11648.88351116495;11713.707157320965;11789.351585662871;14518.709625807636;14519.983601147818;14533.418663253351;14540.563783086523;14572.198529081003;8332.62503187358;8520.275776558938;8585.270252028522;8681.348898832613;8740.475571465733;8545.017323007809;8568.100349463217;8624.69813556535;8726.171013753683;8750.781230469162;4411.713238639478;4507.6168525675685;4518.548145185521;4551.7724113794175;4612.262038073892;1567.5845900836287;1631.3474610156034;1853.7868145163209;1929.5109308991525;1960.725498430221;827.4001349022031;912.2792993535033;942.1097063275276;962.4177372689422;976.5751897924425;20369.694454583194;21086.894565527073;21102.577948440947;21195.152193912072;21433;952.4380615436787;964.4840010594438;978.8238117138841;983.1299300119446;988.5452691761726;10266.691999240034;11005.614803482;11061.889381106246;11119.388433636228;11153.776924461628;582697;591227;592055;594285;603984;110125;128490.35754821353;131500;132508;136995;930.2186163622589;932.8973812880442;962.7929995051097;965.888922773876;966.5264020629841;18203.998780067224;18460.98464584407;18722.157502912672;18799.71800423022;18902.338418155297;50273.24590131224;51727.48272517377;51848.74075629598;57092;57485;79131.60434197792;80134.21277317993;81112.18887811282;81624.59187704023;84194.57902710447;7521.811954700957;7796.298333150044;7831.686732530863;7988.400869934894;8086.989126359205;11753.647390578297;12264.44809983535;12352.876471235173;12779.552715654907;12839.486420543448;10493.422861742678;10633.043026127685;10742.140628749838;11045.94477027642;11098.2786118902;10464.947675261576;10506.737331566772;10729.248952573245;10913.39976301311;11095;9387.249020078241;10590;10706.571737130427;10988.780224395627;11266.94366528162;5930.466258036798;7731.690732370642;7871.252231038042;8017.238362355567;8189.22202390772;9082.636694532144;10833.67498975032;10847;10973.01242888112;11359.54561817518 13:29:14 INFO - PROCESS | 1648 | |3;mootools.html;1332.3005422153374;1511.5994261520698;1530.3954937799567;1745.9127043647813;1919.2438918389682;7836.608169591519;8351.707690230844;8569.614367353468;8762.649494020232;8781.56092195391;8785.121487851227;8876.068012858654;8877.289816814655;8878.911210887889;8882.245009174228;2384.177458776728;2432.1730611592056;2435.0868424340874;2435.512897420514;2442.7435119312395;2396.1373905394044;2414.468816860288;2435.768601982809;2436.11081955086;2436.792872605831;2401.6517604947358;2422.34596658902;2433.7687919647606;2435.8782060896974;2437.8785758551;2380.27401642499;2401.4116541447283;2405.314485371661;2414.6498757680215;2429.8906549205326;2377.9524409511887;2395.748446413136;2398.07674045492;2401.927942161738;2411.770881766229;8727.956360218222;8942.821143577157;8965.551722413853;8995.910040899573;8996.77508062297;5308.867278318073;5495.422980587061;5512.751926163332;5518.310211223597;5538.030844602219;3394.932101357959;3453.2575496268423;3478.7738796978115;3503.579570451562;3524.8942531724088;1090.1551297744231;1100.6257872323367;1105.8894110588958;1108.6230681568225;1108.9168312376603;10422.635207767767;11924;11941.522339106425;12043.096767742367;12057.457414416373;4492.124035813051;4538.886527836765;4700.271457924027;4715.976420117946;4740.715557066587;9092.545372731336;9196.816063678689;9269.165775080275;9282.535873206312;9285.396449230779;5271.6309858310315;5273.868153296198;5284.7886084556185;5289.153735402318;5292.52367286946;3357.364260091242;4008.699347548887;4448.888777780517;4569.840055598104;4936.3829521309835;3550.9644903551152;3858.8070596470066;3883.49514563105;3885.0481631999774;3893.493845800028;1121.3496172220093;1152.757920836617;1153.5616465742964;1154.96535103947;1160.7504386556761;775.2751177648917;889.8131392407538;909.199665031714;916.5371487398821;926.1710768861831;5797.333306669702;5872.970635146797;5893.377447036028;6080.543959203077;6180.505559555225;781.4646966827742;909.7543663211028;921.4931787516839;951.3578334624101;962.4802606592361;3290.391277613649;3529.7176225901867;3743.0268130285776;3774.735768496234;3987.860424885115;10247.487625618838;10772.353658780497;10854.78290434187;10861;10862.511186996604;9318.487483188354;10518.894811051945;10812.567497300177;10813.891861081445;10847;8163.1428699985645;8387;8393.24460798531;8397.118302578141;8403.789905252417;5573.637713548606;5678.0915053591225;5725.341585717696;5843.970780146072;5858.619189752652;10011.34926229822;10065.496725163566;10183.847242291224;10231.539580718736;10286.022827831344;9381.343305968516;9860.556274967501;10245.180385569285;10274.434906080238;10476.895231047592;5989.64062156272;7043.964780176067;7167.641617918979;7221.494495385483;7227.241139680468;8346.833063338578;8357.582120894052;8400.201980811813;8409.159084091541;8472.788180295542;7613.809654758676;7619.352355049883;7655.119661239029;7660.73187438437;7712.498687585289;7456.925430745623;7508.849823003618;7526.811829704301;7567.091948966159;7655.617219139132;6977.7208911642965;7001.264867189076;7009.474289428415;7060.682269297997;7090.822729431806;4883.90232195347;4954.256861470664;4955.603551715926;5008.973160502162;5020.774065167003;4600.1949658810245;4658.231391820312;4822.300766388784;4900.558949694545;5337.279467271868 13:29:14 INFO - PROCESS | 1648 | |4;prototype.html;291.9065898912348;295.92749776304794;305.1760247332203;308.16333654129033;312.23035218187164;4130.421740956261;5161.380634323877;5210.791568337267;5283.392409872861;5342.759575819083;4269.487661480626;4977.427595826481;5107.978404319142;5130.410002849673;5213.149331987137;3963.4451176835264;3968.3849003404516;3985.9202815943663;3992.680585553149;4024.5975402459667;3746.850125994957;3973.3642617181113;4016.3573828187496;4028.7179897407195;4041.2321658884866;3939.5863434339412;3962.2075584882996;3976.1252524444576;3993.520777506689;3993.740406873544;3672.3022625701165;3976.8011599419915;3984.7011474139554;3995.2009598080353;4001.1797581495725;3476.2526056897636;3485.581730192393;3490.5287786148797;3497.7726447780815;3509.2630547585036;4330.657496176164;4919.434265059493;5183.663061901002;5213.435969209222;5237.543221473809;3868.891454157491;3999.2201520703475;4548.4541854977615;4556.2937744649635;4570.96031139292;5591.496765291144;5593.356763972155;5596.244506991545;5603.719814009283;5624.521915637135;3492.912677183065;3731.2910546996254;3735.0288924879455;3765.021094515446;3794.1733408610485;4851.951480485185;5738.426157384228;5767.106098554731;5785.971070144665;5787.829563913532;3223;3807.58116607173;3811.8856434307013;3816.6832442807186;3834.424836274581;3262.4616938205404;3632.7093832493338;3855.8264878080554;3876.282887665791;3884.5532763731967;3932.941005884914;4509.1512479883095;4512.503624601291;4523.208438523246;4544.84093056748;5065.037642847848;5399.488143319877;5625.8312250631725;5631.63394379364;5633.521150702154;1269.676232560691;1298.7532368849888;1302.4855182202978;1309.306067784076;1325.4499382756242;796.7052190689482;867.869819527076;888.4802390601441;891.7191084808264;911.2118017914456;4664.603508701731;4899.608031357483;5259.737013149327;5284.630075894651;5318.654287471302;5305.44292849253;5605.047141985872;5619.747111379916;5691.317041954909;5716.28546431696;4372.322290045048;4523.36672865799;5032.3961124665275;5118.771494841286;5158.742062896915;2217.9445513862283;2255.601527053205;2303.67748515208;2439.7191474476044;2474.1464194853106;3882.6311500407414;3938.6652134568308;4415.359772832921;4705.7411842349;4904.975475122673;4372.475302963601;4518.921296203717;4541.979583576885;4550;4761.2382018876815;4375.190589740908;4474.091840303763;4781.9043619128115;4930.471553818256;4980.726060066659;3907.2185562886966;4054.6007581774106;4098.938515922204;4584.541545845389;4722.622190224705;4075.449814275035;4376.934345984749;4477.552244775497;4731.905361892812;4748.575427371706;4238.533761286194;4801.639877009168;4887.706737595756;4888.633352498648;4917.033186725338;3001.0096668099914;3279.409266679392;3290.901272961815;3355.681210285019;3369.83150842452;3985.5416627088257;4165.729227600196;4652.162395853687;4672.224554669204;4733.650909490779;4177.874663760092;4588.934979259413;4618.822200338892;4629.837955671535;4631.675782695179;4582.518835522222;4611.423572053493;4621.815127394867;4624.745638989888;4664.440267167962;4162.14675991415;4623.976880115712;4958.553730164303;5152.0211159881;5373.704446255493;5551.7779288828;5619.409961953936;5628.60599758013;5638.37977822431;5646.802361917477;4854.19905715553;5119.544307592286;5282.905748045142;5431.701256430934;5481 13:29:14 INFO - PROCESS | 1648 | |5;yui.html;662.5660192573863;732.5860888597941;768.5158350239349;798.7364169823959;829.8464784014958;15106.471273505429;15877.761833572491;16158.272877720501;16169.272382742776;16192.595185120377;13988.37052332645;14858.182799945998;15470.535883923472;15475.613109672264;15703.450379236729;678.762433148399;696.0881245568296;698.9161300643905;820.4707963363627;835.3567752830347;830.1366578758115;840.2857571064608;847.2036285891243;848.7835601921532;855.2601999270618;887.5384799904047;888.9244414224798;889.4752096263203;889.6574818694785;892.5046599137476;699.1505321034916;721.4877437019722;882.9426087304305;884.2263019857625;885.2254277507182;643.4948565376158;655.7114869457423;656.2092678322609;658.5719282466388;661.1438187547138;13048.28234447105;15675.294611742498;15682.451114211062;15694.843051569567;15701.685966280611;13489.730205395936;13700.109492882932;13773.311334433238;13801.102928309629;13854.93072534641;12379.566715164927;12680.556180533637;12831.935840320832;13026.934865325613;13276.800847987288;4533.84131555394;4547.931781023254;4557.430321209848;4665.626749860003;4742.715437073786;117486;118600.40699796446;118851.40574297159;119041;122364.43448958488;10798.190135739695;10875;10959.287646302964;11093.83359249612;11301.660950171508;16347.59131021734;21521.354359369245;21535.67696484554;21567.67648485274;21663.566728665653;7754.961225193951;7788.92211077882;7835.506259324155;7992.440529163019;8100.9873765779275;4355.847545335898;4397.538258482878;4425.181341451842;4448.955510444919;4581.037982023746;3590.425531914881;3747.1756213632957;3757.7745335279424;3760.6427389397963;3773.867914622975;657.6271858912695;696.502001069238;697.0554898112983;697.6023666510142;698.6017969757291;530.4006472685841;575.8560359910023;634.8698516804044;658.7990662847782;662.6521076434814;9042;9525.761855953519;10209.33639313457;10270.691879243635;10284.640037598649;494.653742380328;541.1449909143544;596.8686888884439;653.328294982203;669.4978765925556;4367.606915377568;4644.907101857944;4658.557437043475;4662.927526668886;4672.836450724276;102920;153142.23428882784;161963.19018404832;163038;164417.17791411205;86219;87970.56014720013;127356.72643273634;132029.67970320367;139667;116494;118883;118937.99999999827;120688;123207.76792231963;8636.093210212837;9086;9096.727098187064;9103.951610887761;9354.532273386167;48539.89695717186;62154;62613.37386626076;63225.36774632195;64954.02568961375;95202;96086.03913961051;97535.51232243793;99384.50307748414;108781.36827947429;11749.941250294036;11846.703832404259;11903.928646421864;11991.640250792141;12339.383030848601;12561.183523070971;12793.552225672056;12805.103642744918;14592.781108283172;14678.706425871636;11563;13081.149725267827;13269.270190139248;14374.209418482083;14374.993750437368;13568.864311357154;14266.683770635726;14443.49447769323;14807.185604791839;14828.96197266181;13037.69755980543;13210.537631182862;13996.810271127068;14030.29848507591;14334.784978225543;10871.276832800948;11245.606403775828;11571.85920604691;11917;12175.208611440228;7301.707931682673;10235.846462302923;11250.943745281222;11809.173357864867;11839.467223975114 13:29:14 INFO - PROCESS | 1648 | __end_tp_report 13:29:14 INFO - PROCESS | 1648 | __start_cc_report 13:29:14 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1406 13:29:14 INFO - PROCESS | 1648 | __end_cc_report 13:29:14 INFO - PROCESS | 1648 | __startTimestamp1478899754019__endTimestamp 13:29:14 INFO - PROCESS | 1648 | 13:29:14 INFO - PROCESS | 1648 | ------- Summary: start ------- 13:29:14 INFO - PROCESS | 1648 | Number of tests: 6 13:29:14 INFO - PROCESS | 1648 | 13:29:14 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5766.31 Median:6053.82 stddev:653.22 (10.8%) stddev-sans-first:613.16 13:29:14 INFO - PROCESS | 1648 | Values: 2826.4 3347.9 3396.2 3411.5 3424.6 5716.3 5754.1 5765.3 5771.1 5792.7 5705.3 5796.8 5815.0 5817.3 5819.9 5221.6 5271.3 5292.4 5297.3 5340.3 5228.7 5232.9 5357.9 5377.8 5377.8 5279.6 5283.0 5304.3 5322.4 5323.5 4392.2 5300.7 5309.5 5343.7 5365.3 5221.3 5279.9 5304.1 5309.0 5353.9 5642.3 5700.1 5719.6 5737.9 5750.9 5416.7 6186.6 6249.6 6262.6 6274.8 5453.5 6174.1 6187.8 6232.3 6275.2 5658.9 5665.0 5691.9 5870.2 5917.4 6182.5 6207.1 6219.5 6293.6 6297.0 6181.6 6213.6 6213.6 6218.8 6226.0 6116.3 6164.2 6274.6 6299.5 6307.6 5234.5 6176.8 6212.1 6284.1 6296.7 6211.6 6249.2 6278.9 6296.1 6297.3 4819.4 4952.8 4975.5 4981.2 5000.4 4408.3 4425.0 4461.5 4463.4 4487.3 5951.0 5959.7 5961.0 5961.5 5964.5 6220.4 6238.8 6246.8 6262.1 6262.2 5732.7 5743.0 5802.0 5885.5 5923.0 5428.5 5439.5 5466.1 5466.8 5482.6 6321.7 6327.9 6329.9 6347.4 6353.3 6200.8 6200.9 6272.8 6291.5 6291.8 6211.5 6233.5 6236.7 6255.2 6320.6 6201.8 6222.8 6239.3 6244.8 6245.9 6175.5 6214.1 6258.0 6279.7 6280.5 4871.9 6032.7 6122.4 6130.8 6152.9 6197.4 6213.0 6221.4 6231.3 6236.9 5887.3 6079.4 6088.2 6093.0 6095.8 6089.4 6139.9 6140.2 6142.0 6221.6 5980.9 6053.8 6058.8 6072.7 6085.6 13:29:14 INFO - PROCESS | 1648 | 13:29:14 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:73139.57 Median:35195.15 stddev:167496.03 (475.9%) stddev-sans-first:167877.09 13:29:14 INFO - PROCESS | 1648 | Values: 490.9 522.7 526.5 530.1 534.6 25240.2 40721.6 41659.4 41731.0 41748.4 43001.8 43458.0 43460.0 43494.6 43612.6 9857.1 10051.3 10062.3 10063.0 10064.9 7690.7 9027.5 12003.9 12334.9 12356.8 12187.5 12257.3 12262.6 12282.5 12286.4 8776.0 12206.3 12283.4 12296.1 12301.8 8746.3 11804.5 12099.3 12120.5 12320.8 41046.8 41313.6 41325.4 41350.8 41365.6 3336.5 3366.7 3389.2 3600.8 3606.9 29188.7 30293.7 30415.7 31094.0 31750.9 3160.3 3300.3 3337.8 3381.6 3405.0 375618.1 375628.0 376944.0 377004.0 377813.0 61501.7 61510.1 61713.0 61835.1 61856.7 65061.3 65094.3 65137.0 65145.7 65359.0 16940.4 17166.7 17193.8 17208.7 17211.5 11957.4 12103.0 13121.2 13224.7 13230.3 15353.9 17121.3 17497.7 17511.6 17919.3 6539.5 6580.6 6625.3 6632.8 6637.7 890.6 1025.7 1086.7 1092.9 1112.9 28727.7 29223.0 29954.4 30490.8 30569.2 1113.8 1125.2 1141.1 1154.6 1174.9 15388.4 15525.7 15629.7 15669.6 16036.8 681868.0 688734.0 688856.0 688949.0 695190.0 50364.7 51156.7 51403.0 58721.7 59558.1 1347.2 1377.6 1394.5 1396.6 1399.1 24794.8 30432.5 31748.8 31910.8 32525.7 51566.2 51876.2 51948.0 51981.2 51982.7 653447.7 658072.0 665172.0 847353.0 848742.0 25618.4 25753.5 25980.2 26044.0 26119.1 46446.3 46783.8 46878.3 47204.1 47366.8 38442.8 38742.4 39506.4 39513.0 40803.6 38938.6 39531.0 39662.0 40197.6 40495.6 38016.8 38101.8 38430.8 38917.0 39211.8 33505.2 34765.8 35031.9 35358.4 35475.1 22443.0 25728.6 26021.2 26021.2 26157.6 13:29:14 INFO - PROCESS | 1648 | 13:29:14 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:34911.36 Median:2792.72 stddev:99305.02 (3555.9%) stddev-sans-first:99549.69 13:29:14 INFO - PROCESS | 1648 | Values: 351.5 369.7 372.9 382.2 400.9 15208.2 15236.8 16691.8 20793.8 21041.4 19292.4 19777.5 20150.3 20444.3 20591.9 4775.3 5967.8 6210.6 6211.6 6215.8 5280.4 6147.5 6149.1 6183.3 6188.4 5865.8 6056.8 6141.6 6141.8 6151.1 6051.0 6061.3 6101.7 6103.9 6110.4 5228.6 5275.1 5468.3 5505.3 5586.4 12725.4 12969.1 12984.0 20851.7 25287.2 2174.8 2304.7 2614.7 2653.3 2932.2 10131.7 10297.5 13761.9 14501.3 15010.8 1816.9 1823.4 1830.6 1861.5 1868.8 121824.0 123475.4 126528.4 127791.0 130894.0 9819.9 11236.5 11648.9 11713.7 11789.4 14518.7 14520.0 14533.4 14540.6 14572.2 8332.6 8520.3 8585.3 8681.3 8740.5 8545.0 8568.1 8624.7 8726.2 8750.8 4411.7 4507.6 4518.5 4551.8 4612.3 1567.6 1631.3 1853.8 1929.5 1960.7 827.4 912.3 942.1 962.4 976.6 20369.7 21086.9 21102.6 21195.2 21433.0 952.4 964.5 978.8 983.1 988.5 10266.7 11005.6 11061.9 11119.4 11153.8 582697.0 591227.0 592055.0 594285.0 603984.0 110125.0 128490.4 131500.0 132508.0 136995.0 930.2 932.9 962.8 965.9 966.5 18204.0 18461.0 18722.2 18799.7 18902.3 50273.2 51727.5 51848.7 57092.0 57485.0 79131.6 80134.2 81112.2 81624.6 84194.6 7521.8 7796.3 7831.7 7988.4 8087.0 11753.6 12264.4 12352.9 12779.6 12839.5 10493.4 10633.0 10742.1 11045.9 11098.3 10464.9 10506.7 10729.2 10913.4 11095.0 9387.2 10590.0 10706.6 10988.8 11266.9 5930.5 7731.7 7871.3 8017.2 8189.2 9082.6 10833.7 10847.0 10973.0 11359.5 13:29:14 INFO - PROCESS | 1648 | 13:29:14 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5675.01 Median:4918.47 stddev:3195.38 (65.0%) stddev-sans-first:3187.67 13:29:14 INFO - PROCESS | 1648 | Values: 1332.3 1511.6 1530.4 1745.9 1919.2 7836.6 8351.7 8569.6 8762.6 8781.6 8785.1 8876.1 8877.3 8878.9 8882.2 2384.2 2432.2 2435.1 2435.5 2442.7 2396.1 2414.5 2435.8 2436.1 2436.8 2401.7 2422.3 2433.8 2435.9 2437.9 2380.3 2401.4 2405.3 2414.6 2429.9 2378.0 2395.7 2398.1 2401.9 2411.8 8728.0 8942.8 8965.6 8995.9 8996.8 5308.9 5495.4 5512.8 5518.3 5538.0 3394.9 3453.3 3478.8 3503.6 3524.9 1090.2 1100.6 1105.9 1108.6 1108.9 10422.6 11924.0 11941.5 12043.1 12057.5 4492.1 4538.9 4700.3 4716.0 4740.7 9092.5 9196.8 9269.2 9282.5 9285.4 5271.6 5273.9 5284.8 5289.2 5292.5 3357.4 4008.7 4448.9 4569.8 4936.4 3551.0 3858.8 3883.5 3885.0 3893.5 1121.3 1152.8 1153.6 1155.0 1160.8 775.3 889.8 909.2 916.5 926.2 5797.3 5873.0 5893.4 6080.5 6180.5 781.5 909.8 921.5 951.4 962.5 3290.4 3529.7 3743.0 3774.7 3987.9 10247.5 10772.4 10854.8 10861.0 10862.5 9318.5 10518.9 10812.6 10813.9 10847.0 8163.1 8387.0 8393.2 8397.1 8403.8 5573.6 5678.1 5725.3 5844.0 5858.6 10011.3 10065.5 10183.8 10231.5 10286.0 9381.3 9860.6 10245.2 10274.4 10476.9 5989.6 7044.0 7167.6 7221.5 7227.2 8346.8 8357.6 8400.2 8409.2 8472.8 7613.8 7619.4 7655.1 7660.7 7712.5 7456.9 7508.8 7526.8 7567.1 7655.6 6977.7 7001.3 7009.5 7060.7 7090.8 4883.9 4954.3 4955.6 5009.0 5020.8 4600.2 4658.2 4822.3 4900.6 5337.3 13:29:14 INFO - PROCESS | 1648 | 13:29:14 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4188.12 Median:4546.65 stddev:1268.77 (27.9%) stddev-sans-first:1238.17 13:29:14 INFO - PROCESS | 1648 | Values: 291.9 295.9 305.2 308.2 312.2 4130.4 5161.4 5210.8 5283.4 5342.8 4269.5 4977.4 5108.0 5130.4 5213.1 3963.4 3968.4 3985.9 3992.7 4024.6 3746.9 3973.4 4016.4 4028.7 4041.2 3939.6 3962.2 3976.1 3993.5 3993.7 3672.3 3976.8 3984.7 3995.2 4001.2 3476.3 3485.6 3490.5 3497.8 3509.3 4330.7 4919.4 5183.7 5213.4 5237.5 3868.9 3999.2 4548.5 4556.3 4571.0 5591.5 5593.4 5596.2 5603.7 5624.5 3492.9 3731.3 3735.0 3765.0 3794.2 4852.0 5738.4 5767.1 5786.0 5787.8 3223.0 3807.6 3811.9 3816.7 3834.4 3262.5 3632.7 3855.8 3876.3 3884.6 3932.9 4509.2 4512.5 4523.2 4544.8 5065.0 5399.5 5625.8 5631.6 5633.5 1269.7 1298.8 1302.5 1309.3 1325.4 796.7 867.9 888.5 891.7 911.2 4664.6 4899.6 5259.7 5284.6 5318.7 5305.4 5605.0 5619.7 5691.3 5716.3 4372.3 4523.4 5032.4 5118.8 5158.7 2217.9 2255.6 2303.7 2439.7 2474.1 3882.6 3938.7 4415.4 4705.7 4905.0 4372.5 4518.9 4542.0 4550.0 4761.2 4375.2 4474.1 4781.9 4930.5 4980.7 3907.2 4054.6 4098.9 4584.5 4722.6 4075.4 4376.9 4477.6 4731.9 4748.6 4238.5 4801.6 4887.7 4888.6 4917.0 3001.0 3279.4 3290.9 3355.7 3369.8 3985.5 4165.7 4652.2 4672.2 4733.7 4177.9 4588.9 4618.8 4629.8 4631.7 4582.5 4611.4 4621.8 4624.7 4664.4 4162.1 4624.0 4958.6 5152.0 5373.7 5551.8 5619.4 5628.6 5638.4 5646.8 4854.2 5119.5 5282.9 5431.7 5481.0 13:29:14 INFO - PROCESS | 1648 | 13:29:14 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:25176.03 Median:12627.00 stddev:40538.02 (321.0%) stddev-sans-first:40609.95 13:29:14 INFO - PROCESS | 1648 | Values: 662.6 732.6 768.5 798.7 829.8 15106.5 15877.8 16158.3 16169.3 16192.6 13988.4 14858.2 15470.5 15475.6 15703.5 678.8 696.1 698.9 820.5 835.4 830.1 840.3 847.2 848.8 855.3 887.5 888.9 889.5 889.7 892.5 699.2 721.5 882.9 884.2 885.2 643.5 655.7 656.2 658.6 661.1 13048.3 15675.3 15682.5 15694.8 15701.7 13489.7 13700.1 13773.3 13801.1 13854.9 12379.6 12680.6 12831.9 13026.9 13276.8 4533.8 4547.9 4557.4 4665.6 4742.7 117486.0 118600.4 118851.4 119041.0 122364.4 10798.2 10875.0 10959.3 11093.8 11301.7 16347.6 21521.4 21535.7 21567.7 21663.6 7755.0 7788.9 7835.5 7992.4 8101.0 4355.8 4397.5 4425.2 4449.0 4581.0 3590.4 3747.2 3757.8 3760.6 3773.9 657.6 696.5 697.1 697.6 698.6 530.4 575.9 634.9 658.8 662.7 9042.0 9525.8 10209.3 10270.7 10284.6 494.7 541.1 596.9 653.3 669.5 4367.6 4644.9 4658.6 4662.9 4672.8 102920.0 153142.2 161963.2 163038.0 164417.2 86219.0 87970.6 127356.7 132029.7 139667.0 116494.0 118883.0 118938.0 120688.0 123207.8 8636.1 9086.0 9096.7 9104.0 9354.5 48539.9 62154.0 62613.4 63225.4 64954.0 95202.0 96086.0 97535.5 99384.5 108781.4 11749.9 11846.7 11903.9 11991.6 12339.4 12561.2 12793.6 12805.1 14592.8 14678.7 11563.0 13081.1 13269.3 14374.2 14375.0 13568.9 14266.7 14443.5 14807.2 14829.0 13037.7 13210.5 13996.8 14030.3 14334.8 10871.3 11245.6 11571.9 11917.0 12175.2 7301.7 10235.8 11250.9 11809.2 11839.5 13:29:14 INFO - PROCESS | 1648 | -------- Summary: end -------- 13:29:14 INFO - PROCESS | 1648 | 13:29:14 INFO - TEST-INFO | 1648: exit 0 13:29:14 INFO - TEST-OK | dromaeo_css | took 1117468ms 13:29:14 INFO - TEST-START | kraken 13:29:14 INFO - operating with platform_type : mac_ 13:29:14 INFO - Initialising browser for kraken test... 13:29:14 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmp7MHeX9/profile http://localhost:49276/getInfo.html) 13:29:16 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 13:29:16 INFO - PROCESS | 1657 | colorDepth:24 13:29:16 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 13:29:16 INFO - PROCESS | 1657 | __metrics 13:29:17 INFO - PROCESS | 1657 | 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" 13:29:17 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:29:17 INFO - TEST-INFO | 1657: exit 0 13:29:17 INFO - Browser initialized. 13:29:17 INFO - Running cycle 1/1 for kraken test... 13:29:17 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmp7MHeX9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:29:29 INFO - PROCESS | 1658 | RSS: Main: 219766784 13:29:29 INFO - PROCESS | 1658 | 13:29:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 13:29:33 INFO - PROCESS | 1658 | RSS: Main: 270114816 13:29:33 INFO - PROCESS | 1658 | 13:29:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 13:29:36 INFO - PROCESS | 1658 | RSS: Main: 280510464 13:29:36 INFO - PROCESS | 1658 | 13:29:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 13:29:40 INFO - PROCESS | 1658 | RSS: Main: 379002880 13:29:40 INFO - PROCESS | 1658 | 13:29:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 13:29:43 INFO - PROCESS | 1658 | RSS: Main: 280502272 13:29:43 INFO - PROCESS | 1658 | 13:29:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:29:45 INFO - PROCESS | 1658 | RSS: Main: 282497024 13:29:45 INFO - PROCESS | 1658 | 13:29:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 13:29:49 INFO - PROCESS | 1658 | RSS: Main: 319172608 13:29:49 INFO - PROCESS | 1658 | 13:29:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 13:29:52 INFO - PROCESS | 1658 | RSS: Main: 318369792 13:29:52 INFO - PROCESS | 1658 | 13:29:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 13:29:56 INFO - PROCESS | 1658 | RSS: Main: 315363328 13:29:56 INFO - PROCESS | 1658 | 13:29:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:29:58 INFO - PROCESS | 1658 | RSS: Main: 291631104 13:29:58 INFO - PROCESS | 1658 | 13:30:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:30:00 INFO - PROCESS | 1658 | RSS: Main: 294141952 13:30:00 INFO - PROCESS | 1658 | 13:30:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:30:03 INFO - PROCESS | 1658 | RSS: Main: 298123264 13:30:03 INFO - PROCESS | 1658 | 13:30:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:30:07 INFO - PROCESS | 1658 | RSS: Main: 309256192 13:30:07 INFO - PROCESS | 1658 | 13:30:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:30:10 INFO - PROCESS | 1658 | RSS: Main: 309268480 13:30:10 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 13:30:12 INFO - PROCESS | 1658 | RSS: Main: 353251328 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | __start_tp_report 13:30:12 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 13:30:12 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 13:30:12 INFO - PROCESS | 1658 | |i|pagename|runs| 13:30:12 INFO - PROCESS | 1658 | |0;ai-astar;116;113;116;113;114;114;114;114;114;112 13:30:12 INFO - PROCESS | 1658 | |1;audio-beat-detection;144;118;134;151;108;104;109;108;139;106 13:30:12 INFO - PROCESS | 1658 | |2;audio-dft;183;181;181;184;183;182;183;194;256;204 13:30:12 INFO - PROCESS | 1658 | |3;audio-fft;80;60;59;89;58;59;58;58;83;57 13:30:12 INFO - PROCESS | 1658 | |4;audio-oscillator;81;72;89;64;68;68;91;66;68;89 13:30:12 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;89;86;89;87;88;86;90;86;89;85 13:30:12 INFO - PROCESS | 1658 | |6;imaging-darkroom;94;94;96;109;150;112;95;96;96;96 13:30:12 INFO - PROCESS | 1658 | |7;imaging-desaturate;86;83;85;87;87;86;85;87;85;85 13:30:12 INFO - PROCESS | 1658 | |8;json-parse-financial;59;54;54;56;56;57;56;56;56;57 13:30:12 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;75;69;67;78;74;71;71;71;72;75 13:30:12 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;83;82;81;83;82;81;79;83;85;83 13:30:12 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;133;128;172;154;136;142;138;141;171;137 13:30:12 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;164;162;164;163;167;164;170;160;163;163 13:30:12 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;66;67;65;67;67;67;65;66;66;66 13:30:12 INFO - PROCESS | 1658 | __end_tp_report 13:30:12 INFO - PROCESS | 1658 | __start_cc_report 13:30:12 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1979 13:30:12 INFO - PROCESS | 1658 | __end_cc_report 13:30:12 INFO - PROCESS | 1658 | __startTimestamp1478899812423__endTimestamp 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | ------- Summary: start ------- 13:30:12 INFO - PROCESS | 1658 | Number of tests: 14 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:1.09 13:30:12 INFO - PROCESS | 1658 | Values: 116.0 113.0 116.0 113.0 114.0 114.0 114.0 114.0 114.0 112.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:126.00 stddev:18.00 (14.3%) stddev-sans-first:17.26 13:30:12 INFO - PROCESS | 1658 | Values: 144.0 118.0 134.0 151.0 108.0 104.0 109.0 108.0 139.0 106.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:193.10 Median:183.50 stddev:23.29 (12.7%) stddev-sans-first:24.41 13:30:12 INFO - PROCESS | 1658 | Values: 183.0 181.0 181.0 184.0 183.0 182.0 183.0 194.0 256.0 204.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:66.10 Median:59.50 stddev:12.56 (21.1%) stddev-sans-first:12.28 13:30:12 INFO - PROCESS | 1658 | Values: 80.0 60.0 59.0 89.0 58.0 59.0 58.0 58.0 83.0 57.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.50 stddev:10.74 (14.0%) stddev-sans-first:11.21 13:30:12 INFO - PROCESS | 1658 | Values: 81.0 72.0 89.0 64.0 68.0 68.0 91.0 66.0 68.0 89.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:1.72 (1.9%) stddev-sans-first:1.73 13:30:12 INFO - PROCESS | 1658 | Values: 89.0 86.0 89.0 87.0 88.0 86.0 90.0 86.0 89.0 85.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:103.80 Median:95.50 stddev:17.45 (18.3%) stddev-sans-first:18.15 13:30:12 INFO - PROCESS | 1658 | Values: 94.0 94.0 96.0 109.0 150.0 112.0 95.0 96.0 96.0 96.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 13:30:12 INFO - PROCESS | 1658 | Values: 86.0 83.0 85.0 87.0 87.0 86.0 85.0 87.0 85.0 85.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.45 (2.6%) stddev-sans-first:1.09 13:30:12 INFO - PROCESS | 1658 | Values: 59.0 54.0 54.0 56.0 56.0 57.0 56.0 56.0 56.0 57.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:73.00 stddev:3.23 (4.4%) stddev-sans-first:3.28 13:30:12 INFO - PROCESS | 1658 | Values: 75.0 69.0 67.0 78.0 74.0 71.0 71.0 71.0 72.0 75.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:83.00 stddev:1.62 (2.0%) stddev-sans-first:1.69 13:30:12 INFO - PROCESS | 1658 | Values: 83.0 82.0 81.0 83.0 82.0 81.0 79.0 83.0 85.0 83.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:141.50 stddev:15.41 (10.9%) stddev-sans-first:15.70 13:30:12 INFO - PROCESS | 1658 | Values: 133.0 128.0 172.0 154.0 136.0 142.0 138.0 141.0 171.0 137.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.00 stddev:2.75 (1.7%) stddev-sans-first:2.92 13:30:12 INFO - PROCESS | 1658 | Values: 164.0 162.0 164.0 163.0 167.0 164.0 170.0 160.0 163.0 163.0 13:30:12 INFO - PROCESS | 1658 | 13:30:12 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 13:30:12 INFO - PROCESS | 1658 | Values: 66.0 67.0 65.0 67.0 67.0 67.0 65.0 66.0 66.0 66.0 13:30:12 INFO - PROCESS | 1658 | -------- Summary: end -------- 13:30:12 INFO - PROCESS | 1658 | 13:30:13 INFO - TEST-INFO | 1658: exit 0 13:30:13 INFO - TEST-OK | kraken | took 58660ms 13:30:13 INFO - SUITE-END | took 1176s 13:30:13 INFO - Completed test suite (00:19:36) 13:30:13 INFO - javascript benchmark 13:30:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2826.420583780325, 3347.9497807532885, 3396.184915620252, 3411.471221960597, 3424.606170290416, 5716.28546431696, 5754.108113242454, 5765.279340082489, 5771.076627739562, 5792.710364481775, 5705.286839145107, 5796.768129274824, 5815.0, 5817.301923769143, 5819.912701309484, 5221.634485586011, 5271.314729085214, 5292.391374991867, 5297.337832770903, 5340.305760251162, 5228.660137091096, 5232.895342093156, 5357.946420535804, 5377.7580008899495, 5377.8117765878205, 5279.577633789288, 5282.973585132069, 5304.310439642841, 5322.4411436799155, 5323.547498462616, 4392.16548855718, 5300.655457395257, 5309.52214300711, 5343.652662576959, 5365.3293338332705, 5221.269022336875, 5279.947200528022, 5304.071787437221, 5308.973455132738, 5353.892922141536, 5642.294713160855, 5700.144978253254, 5719.571032172562, 5737.913931291034, 5750.913736293959, 5416.729163541847, 6186.597871138361, 6249.625022498664, 6262.561620686553, 6274.811755647338, 5453.481919217668, 6174.073888916653, 6187.81436556904, 6232.25212974446, 6275.184226050585, 5658.943410565924, 5665.036943719495, 5691.943080569141, 5870.236869207061, 5917.437843404869, 6182.505399568024, 6207.099970504251, 6219.533534984895, 6293.590916590407, 6297.023961286008, 6181.629102253879, 6213.596116252519, 6213.627182369072, 6218.81343559694, 6225.968870155621, 6116.33577150815, 6164.229471316085, 6274.592151510137, 6299.464545513591, 6307.590006649553, 5234.502722241381, 6176.81469555914, 6212.099245609452, 6284.12022316876, 6296.685165741695, 6211.627302361872, 6249.187605611241, 6278.905816412757, 6296.118543403927, 6297.338779428185, 4819.373481447389, 4952.801887924515, 4975.502449755068, 4981.153203955337, 5000.39995200571, 4408.338749187647, 4425.048614547888, 4461.531539188403, 4463.419755431838, 4487.304467807495, 5951.047832346891, 5959.672218027963, 5961.0, 5961.493273071751, 5964.522838172936, 6220.409061139185, 6238.812835614939, 6246.843828904313, 6262.12330273762, 6262.1859158310035, 5732.6847023413275, 5743.0, 5801.970990145022, 5885.47030767233, 5923.0, 5428.45715428454, 5439.5376393006245, 5466.125419932791, 5466.781328746885, 5482.616216864782, 6321.652309123042, 6327.873442531216, 6329.936700632935, 6347.39699728525, 6353.3011368748475, 6200.844978875564, 6200.852842224203, 6272.8118156455375, 6291.528135389955, 6291.842703932438, 6211.472024877755, 6233.532485063548, 6236.688165591793, 6255.24937007562, 6320.5575609706875, 6201.782937597343, 6222.782202623068, 6239.251289845248, 6244.843878902882, 6245.9069662807915, 6175.505959523138, 6214.098955651496, 6258.0, 6279.71741271653, 6280.5289603279025, 4871.9269210962575, 6032.698365081641, 6122.39815511198, 6130.846728831815, 6152.907706384318, 6197.380261973947, 6212.968935155295, 6221.440070393686, 6231.345708700521, 6236.937630623817, 5887.260755092021, 6079.392060793885, 6088.150830315894, 6092.9882830978195, 6095.786647467317, 6089.391060893875, 6139.9079013813935, 6140.17107690456, 6142.04798256271, 6221.595596286227, 5980.850478738066, 6053.818385448443, 6058.818235452944, 6072.666003369857, 6085.604435711664], "value": 5724.161814945761, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.8944576915965, 522.6628824408257, 526.4682670502791, 530.0750190916849, 534.6337758635335, 25240.242792716203, 40721.59278407215, 41659.375109373344, 41731.0, 41748.37377439341, 43001.784991075, 43458.0, 43460.0, 43494.56505434945, 43612.56387436124, 9857.063578960006, 10051.346662466953, 10062.345947513424, 10063.0, 10064.899351006507, 7690.692372305129, 9027.458352498837, 12003.939980300087, 12334.876651233508, 12356.814647780291, 12187.512499500053, 12257.26456412618, 12262.632121036339, 12282.508699652004, 12286.447109880077, 8775.956120219358, 12206.328651924141, 12283.385830708428, 12296.139270251086, 12301.753964920741, 8746.34402419821, 11804.52781888732, 12099.274043557414, 12120.45457954394, 12320.81518777219, 41046.79476602598, 41313.58686413128, 41325.380119298236, 41350.79324603388, 41365.58634413647, 3336.4661654135466, 3366.6801653842845, 3389.237421580149, 3600.819959002066, 3606.945895811565, 29188.708112918812, 30293.697063029307, 30415.695843041507, 31094.0, 31750.888718894726, 3160.336329370812, 3300.290437555937, 3337.8331083445732, 3381.5944078226685, 3405.0465869556565, 375618.1219093914, 375628.0, 376944.0, 377004.0, 377813.0, 61501.69249153726, 61510.077348839804, 61713.0, 61835.07247391293, 61856.69071654613, 65061.349386506474, 65094.349056509775, 65137.0, 65145.67427162929, 65359.019614705816, 16940.40708575194, 17166.742498862528, 17193.828061719472, 17208.741868871977, 17211.483655490356, 11957.402129893471, 12103.031757459383, 13121.212727236396, 13224.669383265304, 13230.272335021666, 15353.923230383776, 17121.315147393965, 17497.650046998988, 17511.64976700459, 17919.283228670967, 6539.50953678476, 6580.5722628029025, 6625.3043430440075, 6632.767853125118, 6637.668116594151, 890.6214858685033, 1025.738436698637, 1086.723100357093, 1092.9344239345664, 1112.866456025266, 28727.712722872922, 29222.977195798045, 29954.400911982073, 30490.847545762572, 30569.23576910595, 1113.8050841102774, 1125.234840308598, 1141.149843366697, 1154.5670373609896, 1174.929504229749, 15388.38446462129, 15525.689486210213, 15629.68740625181, 15669.60825979337, 16036.839631603534, 681868.0, 688734.0, 688856.0, 688949.0, 695190.0, 50364.740881477526, 51156.744216279425, 51402.97194056173, 58721.70639146777, 59558.10662840061, 1347.2320777157122, 1377.5591810620706, 1394.5188909826093, 1396.5670642100981, 1399.0556374447208, 24794.752052479245, 30432.543511847784, 31748.841255793574, 31910.84044579762, 32525.67474325321, 51566.22650660168, 51876.221856672935, 51948.0, 51981.22028169656, 51982.70043248949, 653447.7327613331, 658072.0, 665172.0, 847353.0, 848742.0, 25618.35954101088, 25753.484930300914, 25980.22059338223, 26044.0, 26119.085831995788, 46446.30330544977, 46783.76608116938, 46878.29682554696, 47204.05591888211, 47366.76316618395, 38442.80778596089, 38742.418863717634, 39506.40740388839, 39513.0, 40803.59196407998, 38938.6106138935, 39531.0, 39662.008449788984, 40197.59802401938, 40495.59504404918, 38016.809915950245, 38101.809490952364, 38430.84707458781, 38917.02707432337, 39211.80394098011, 33505.162370940925, 34765.826170869994, 35031.89808611492, 35358.408871600324, 35475.11312217215, 22443.0, 25728.61407078933, 26021.219363419128, 26021.219363419128, 26157.60763588586], "value": 20520.73918635182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4938488576448, 369.65806628868296, 372.895589235014, 382.22027064787824, 400.8556919508976, 15208.239588020597, 15236.847631523682, 16691.83308166918, 20793.792062079374, 21041.368758937217, 19292.421227363167, 19777.50556236091, 20150.294739684115, 20444.28445004425, 20591.897040514777, 4775.331453596499, 5967.8209653710455, 6210.596311239755, 6211.596246244002, 6215.81352559424, 5280.392754833186, 6147.477464415508, 6149.13912052313, 6183.319834818189, 6188.350223226564, 5865.794697185599, 6056.818295451144, 6141.631502109865, 6141.815745527641, 6151.077338399231, 6050.969745151268, 6061.333253342129, 6101.725422355982, 6103.938960610403, 6110.3889611038985, 5228.5555727763185, 5275.050490911634, 5468.26178465906, 5505.311836020497, 5586.385497595261, 12725.42735576892, 12969.092163548556, 12984.0, 20851.687224691643, 25287.241382758548, 2174.824337272425, 2304.686328792589, 2614.686237651494, 2653.2703506535663, 2932.1643331650375, 10131.696049118538, 10297.485125743759, 13761.862381376159, 14501.274936253145, 15010.774838377432, 1816.909154542281, 1823.4298795660318, 1830.5698160932304, 1861.5067007243092, 1868.785089714673, 121824.0, 123475.38262308721, 126528.36735816354, 127791.0, 130894.0, 9819.852702209473, 11236.494357753922, 11648.88351116495, 11713.707157320965, 11789.351585662871, 14518.709625807636, 14519.983601147818, 14533.418663253351, 14540.563783086523, 14572.198529081003, 8332.62503187358, 8520.275776558938, 8585.270252028522, 8681.348898832613, 8740.475571465733, 8545.017323007809, 8568.100349463217, 8624.69813556535, 8726.171013753683, 8750.781230469162, 4411.713238639478, 4507.6168525675685, 4518.548145185521, 4551.7724113794175, 4612.262038073892, 1567.5845900836287, 1631.3474610156034, 1853.7868145163209, 1929.5109308991525, 1960.725498430221, 827.4001349022031, 912.2792993535033, 942.1097063275276, 962.4177372689422, 976.5751897924425, 20369.694454583194, 21086.894565527073, 21102.577948440947, 21195.152193912072, 21433.0, 952.4380615436787, 964.4840010594438, 978.8238117138841, 983.1299300119446, 988.5452691761726, 10266.691999240034, 11005.614803482, 11061.889381106246, 11119.388433636228, 11153.776924461628, 582697.0, 591227.0, 592055.0, 594285.0, 603984.0, 110125.0, 128490.35754821353, 131500.0, 132508.0, 136995.0, 930.2186163622589, 932.8973812880442, 962.7929995051097, 965.888922773876, 966.5264020629841, 18203.998780067224, 18460.98464584407, 18722.157502912672, 18799.71800423022, 18902.338418155297, 50273.24590131224, 51727.48272517377, 51848.74075629598, 57092.0, 57485.0, 79131.60434197792, 80134.21277317993, 81112.18887811282, 81624.59187704023, 84194.57902710447, 7521.811954700957, 7796.298333150044, 7831.686732530863, 7988.400869934894, 8086.989126359205, 11753.647390578297, 12264.44809983535, 12352.876471235173, 12779.552715654907, 12839.486420543448, 10493.422861742678, 10633.043026127685, 10742.140628749838, 11045.94477027642, 11098.2786118902, 10464.947675261576, 10506.737331566772, 10729.248952573245, 10913.39976301311, 11095.0, 9387.249020078241, 10590.0, 10706.571737130427, 10988.780224395627, 11266.94366528162, 5930.466258036798, 7731.690732370642, 7871.252231038042, 8017.238362355567, 8189.22202390772, 9082.636694532144, 10833.67498975032, 10847.0, 10973.01242888112, 11359.54561817518], "value": 9462.910657528591, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.3005422153374, 1511.5994261520698, 1530.3954937799567, 1745.9127043647813, 1919.2438918389682, 7836.608169591519, 8351.707690230844, 8569.614367353468, 8762.649494020232, 8781.56092195391, 8785.121487851227, 8876.068012858654, 8877.289816814655, 8878.911210887889, 8882.245009174228, 2384.177458776728, 2432.1730611592056, 2435.0868424340874, 2435.512897420514, 2442.7435119312395, 2396.1373905394044, 2414.468816860288, 2435.768601982809, 2436.11081955086, 2436.792872605831, 2401.6517604947358, 2422.34596658902, 2433.7687919647606, 2435.8782060896974, 2437.8785758551, 2380.27401642499, 2401.4116541447283, 2405.314485371661, 2414.6498757680215, 2429.8906549205326, 2377.9524409511887, 2395.748446413136, 2398.07674045492, 2401.927942161738, 2411.770881766229, 8727.956360218222, 8942.821143577157, 8965.551722413853, 8995.910040899573, 8996.77508062297, 5308.867278318073, 5495.422980587061, 5512.751926163332, 5518.310211223597, 5538.030844602219, 3394.932101357959, 3453.2575496268423, 3478.7738796978115, 3503.579570451562, 3524.8942531724088, 1090.1551297744231, 1100.6257872323367, 1105.8894110588958, 1108.6230681568225, 1108.9168312376603, 10422.635207767767, 11924.0, 11941.522339106425, 12043.096767742367, 12057.457414416373, 4492.124035813051, 4538.886527836765, 4700.271457924027, 4715.976420117946, 4740.715557066587, 9092.545372731336, 9196.816063678689, 9269.165775080275, 9282.535873206312, 9285.396449230779, 5271.6309858310315, 5273.868153296198, 5284.7886084556185, 5289.153735402318, 5292.52367286946, 3357.364260091242, 4008.699347548887, 4448.888777780517, 4569.840055598104, 4936.3829521309835, 3550.9644903551152, 3858.8070596470066, 3883.49514563105, 3885.0481631999774, 3893.493845800028, 1121.3496172220093, 1152.757920836617, 1153.5616465742964, 1154.96535103947, 1160.7504386556761, 775.2751177648917, 889.8131392407538, 909.199665031714, 916.5371487398821, 926.1710768861831, 5797.333306669702, 5872.970635146797, 5893.377447036028, 6080.543959203077, 6180.505559555225, 781.4646966827742, 909.7543663211028, 921.4931787516839, 951.3578334624101, 962.4802606592361, 3290.391277613649, 3529.7176225901867, 3743.0268130285776, 3774.735768496234, 3987.860424885115, 10247.487625618838, 10772.353658780497, 10854.78290434187, 10861.0, 10862.511186996604, 9318.487483188354, 10518.894811051945, 10812.567497300177, 10813.891861081445, 10847.0, 8163.1428699985645, 8387.0, 8393.24460798531, 8397.118302578141, 8403.789905252417, 5573.637713548606, 5678.0915053591225, 5725.341585717696, 5843.970780146072, 5858.619189752652, 10011.34926229822, 10065.496725163566, 10183.847242291224, 10231.539580718736, 10286.022827831344, 9381.343305968516, 9860.556274967501, 10245.180385569285, 10274.434906080238, 10476.895231047592, 5989.64062156272, 7043.964780176067, 7167.641617918979, 7221.494495385483, 7227.241139680468, 8346.833063338578, 8357.582120894052, 8400.201980811813, 8409.159084091541, 8472.788180295542, 7613.809654758676, 7619.352355049883, 7655.119661239029, 7660.73187438437, 7712.498687585289, 7456.925430745623, 7508.849823003618, 7526.811829704301, 7567.091948966159, 7655.617219139132, 6977.7208911642965, 7001.264867189076, 7009.474289428415, 7060.682269297997, 7090.822729431806, 4883.90232195347, 4954.256861470664, 4955.603551715926, 5008.973160502162, 5020.774065167003, 4600.1949658810245, 4658.231391820312, 4822.300766388784, 4900.558949694545, 5337.279467271868], "value": 4553.368438128737, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.9065898912348, 295.92749776304794, 305.1760247332203, 308.16333654129033, 312.23035218187164, 4130.421740956261, 5161.380634323877, 5210.791568337267, 5283.392409872861, 5342.759575819083, 4269.487661480626, 4977.427595826481, 5107.978404319142, 5130.410002849673, 5213.149331987137, 3963.4451176835264, 3968.3849003404516, 3985.9202815943663, 3992.680585553149, 4024.5975402459667, 3746.850125994957, 3973.3642617181113, 4016.3573828187496, 4028.7179897407195, 4041.2321658884866, 3939.5863434339412, 3962.2075584882996, 3976.1252524444576, 3993.520777506689, 3993.740406873544, 3672.3022625701165, 3976.8011599419915, 3984.7011474139554, 3995.2009598080353, 4001.1797581495725, 3476.2526056897636, 3485.581730192393, 3490.5287786148797, 3497.7726447780815, 3509.2630547585036, 4330.657496176164, 4919.434265059493, 5183.663061901002, 5213.435969209222, 5237.543221473809, 3868.891454157491, 3999.2201520703475, 4548.4541854977615, 4556.2937744649635, 4570.96031139292, 5591.496765291144, 5593.356763972155, 5596.244506991545, 5603.719814009283, 5624.521915637135, 3492.912677183065, 3731.2910546996254, 3735.0288924879455, 3765.021094515446, 3794.1733408610485, 4851.951480485185, 5738.426157384228, 5767.106098554731, 5785.971070144665, 5787.829563913532, 3223.0, 3807.58116607173, 3811.8856434307013, 3816.6832442807186, 3834.424836274581, 3262.4616938205404, 3632.7093832493338, 3855.8264878080554, 3876.282887665791, 3884.5532763731967, 3932.941005884914, 4509.1512479883095, 4512.503624601291, 4523.208438523246, 4544.84093056748, 5065.037642847848, 5399.488143319877, 5625.8312250631725, 5631.63394379364, 5633.521150702154, 1269.676232560691, 1298.7532368849888, 1302.4855182202978, 1309.306067784076, 1325.4499382756242, 796.7052190689482, 867.869819527076, 888.4802390601441, 891.7191084808264, 911.2118017914456, 4664.603508701731, 4899.608031357483, 5259.737013149327, 5284.630075894651, 5318.654287471302, 5305.44292849253, 5605.047141985872, 5619.747111379916, 5691.317041954909, 5716.28546431696, 4372.322290045048, 4523.36672865799, 5032.3961124665275, 5118.771494841286, 5158.742062896915, 2217.9445513862283, 2255.601527053205, 2303.67748515208, 2439.7191474476044, 2474.1464194853106, 3882.6311500407414, 3938.6652134568308, 4415.359772832921, 4705.7411842349, 4904.975475122673, 4372.475302963601, 4518.921296203717, 4541.979583576885, 4550.0, 4761.2382018876815, 4375.190589740908, 4474.091840303763, 4781.9043619128115, 4930.471553818256, 4980.726060066659, 3907.2185562886966, 4054.6007581774106, 4098.938515922204, 4584.541545845389, 4722.622190224705, 4075.449814275035, 4376.934345984749, 4477.552244775497, 4731.905361892812, 4748.575427371706, 4238.533761286194, 4801.639877009168, 4887.706737595756, 4888.633352498648, 4917.033186725338, 3001.0096668099914, 3279.409266679392, 3290.901272961815, 3355.681210285019, 3369.83150842452, 3985.5416627088257, 4165.729227600196, 4652.162395853687, 4672.224554669204, 4733.650909490779, 4177.874663760092, 4588.934979259413, 4618.822200338892, 4629.837955671535, 4631.675782695179, 4582.518835522222, 4611.423572053493, 4621.815127394867, 4624.745638989888, 4664.440267167962, 4162.14675991415, 4623.976880115712, 4958.553730164303, 5152.0211159881, 5373.704446255493, 5551.7779288828, 5619.409961953936, 5628.60599758013, 5638.37977822431, 5646.802361917477, 4854.19905715553, 5119.544307592286, 5282.905748045142, 5431.701256430934, 5481.0], "value": 3795.4485179932326, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.5660192573863, 732.5860888597941, 768.5158350239349, 798.7364169823959, 829.8464784014958, 15106.471273505429, 15877.761833572491, 16158.272877720501, 16169.272382742776, 16192.595185120377, 13988.37052332645, 14858.182799945998, 15470.535883923472, 15475.613109672264, 15703.450379236729, 678.762433148399, 696.0881245568296, 698.9161300643905, 820.4707963363627, 835.3567752830347, 830.1366578758115, 840.2857571064608, 847.2036285891243, 848.7835601921532, 855.2601999270618, 887.5384799904047, 888.9244414224798, 889.4752096263203, 889.6574818694785, 892.5046599137476, 699.1505321034916, 721.4877437019722, 882.9426087304305, 884.2263019857625, 885.2254277507182, 643.4948565376158, 655.7114869457423, 656.2092678322609, 658.5719282466388, 661.1438187547138, 13048.28234447105, 15675.294611742498, 15682.451114211062, 15694.843051569567, 15701.685966280611, 13489.730205395936, 13700.109492882932, 13773.311334433238, 13801.102928309629, 13854.93072534641, 12379.566715164927, 12680.556180533637, 12831.935840320832, 13026.934865325613, 13276.800847987288, 4533.84131555394, 4547.931781023254, 4557.430321209848, 4665.626749860003, 4742.715437073786, 117486.0, 118600.40699796446, 118851.40574297159, 119041.0, 122364.43448958488, 10798.190135739695, 10875.0, 10959.287646302964, 11093.83359249612, 11301.660950171508, 16347.59131021734, 21521.354359369245, 21535.67696484554, 21567.67648485274, 21663.566728665653, 7754.961225193951, 7788.92211077882, 7835.506259324155, 7992.440529163019, 8100.9873765779275, 4355.847545335898, 4397.538258482878, 4425.181341451842, 4448.955510444919, 4581.037982023746, 3590.425531914881, 3747.1756213632957, 3757.7745335279424, 3760.6427389397963, 3773.867914622975, 657.6271858912695, 696.502001069238, 697.0554898112983, 697.6023666510142, 698.6017969757291, 530.4006472685841, 575.8560359910023, 634.8698516804044, 658.7990662847782, 662.6521076434814, 9042.0, 9525.761855953519, 10209.33639313457, 10270.691879243635, 10284.640037598649, 494.653742380328, 541.1449909143544, 596.8686888884439, 653.328294982203, 669.4978765925556, 4367.606915377568, 4644.907101857944, 4658.557437043475, 4662.927526668886, 4672.836450724276, 102920.0, 153142.23428882784, 161963.19018404832, 163038.0, 164417.17791411205, 86219.0, 87970.56014720013, 127356.72643273634, 132029.67970320367, 139667.0, 116494.0, 118883.0, 118937.99999999827, 120688.0, 123207.76792231963, 8636.093210212837, 9086.0, 9096.727098187064, 9103.951610887761, 9354.532273386167, 48539.89695717186, 62154.0, 62613.37386626076, 63225.36774632195, 64954.02568961375, 95202.0, 96086.03913961051, 97535.51232243793, 99384.50307748414, 108781.36827947429, 11749.941250294036, 11846.703832404259, 11903.928646421864, 11991.640250792141, 12339.383030848601, 12561.183523070971, 12793.552225672056, 12805.103642744918, 14592.781108283172, 14678.706425871636, 11563.0, 13081.149725267827, 13269.270190139248, 14374.209418482083, 14374.993750437368, 13568.864311357154, 14266.683770635726, 14443.49447769323, 14807.185604791839, 14828.96197266181, 13037.69755980543, 13210.537631182862, 13996.810271127068, 14030.29848507591, 14334.784978225543, 10871.276832800948, 11245.606403775828, 11571.85920604691, 11917.0, 12175.208611440228, 7301.707931682673, 10235.846462302923, 11250.943745281222, 11809.173357864867, 11839.467223975114], "value": 7836.558570682172, "unit": "score"}], "name": "dromaeo_css", "value": 7293.74037252411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 116.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 112.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 134.0, 151.0, 108.0, 104.0, 109.0, 108.0, 139.0, 106.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 181.0, 184.0, 183.0, 182.0, 183.0, 194.0, 256.0, 204.0], "value": 193.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 89.0, 58.0, 59.0, 58.0, 58.0, 83.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 72.0, 89.0, 64.0, 68.0, 68.0, 91.0, 66.0, 68.0, 89.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 88.0, 86.0, 90.0, 86.0, 89.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 109.0, 150.0, 112.0, 95.0, 96.0, 96.0, 96.0], "value": 103.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 87.0, 87.0, 86.0, 85.0, 87.0, 85.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 54.0, 54.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 69.0, 67.0, 78.0, 74.0, 71.0, 71.0, 71.0, 72.0, 75.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 81.0, 83.0, 82.0, 81.0, 79.0, 83.0, 85.0, 83.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 172.0, 154.0, 136.0, 142.0, 138.0, 141.0, 171.0, 137.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 163.0, 167.0, 164.0, 170.0, 160.0, 163.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 67.0, 67.0, 67.0, 65.0, 66.0, 66.0, 66.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1433.8, "alertThreshold": 2.0}]} 13:30:13 INFO - Return code: 0 13:30:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:30:13 INFO - # TBPL SUCCESS # 13:30:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:30:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:30:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:30:13 INFO - 2016-11-11 13:30:13.777 screenresolution[1663:9789] starting screenresolution argv=screenresolution get 13:30:13 INFO - 2016-11-11 13:30:13.779 screenresolution[1663:9789] Display 0: 1600x1200x32@60 13:30:13 INFO - 2016-11-11 13:30:13.785 screenresolution[1664:9792] starting screenresolution argv=screenresolution list 13:30:13 INFO - Available Modes on Display 0 13:30:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:30:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:30:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:30:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:30:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:30:14 INFO - Intel Iris: 13:30:14 INFO - Chipset Model: Intel Iris 13:30:14 INFO - Type: GPU 13:30:14 INFO - Bus: Built-In 13:30:14 INFO - VRAM (Dynamic, Max): 1536 MB 13:30:14 INFO - Vendor: Intel (0x8086) 13:30:14 INFO - Device ID: 0x0a2e 13:30:14 INFO - Revision ID: 0x0009 13:30:14 INFO - Displays: 13:30:14 INFO - Display: 13:30:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:30:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:30:14 INFO - Display Serial Number: 1600x1200 60 13:30:14 INFO - Main Display: Yes 13:30:14 INFO - Mirror: Off 13:30:14 INFO - Online: Yes 13:30:14 INFO - Rotation: Supported 13:30:14 INFO - Return code: 0 13:30:14 INFO - Running post-action listener: _resource_record_post_action 13:30:14 INFO - [mozharness: 2016-11-11 21:30:14.022525Z] Finished run-tests step (success) 13:30:14 INFO - Running post-run listener: _resource_record_post_run 13:30:14 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37561344; Write bytes: 662895104; Read time: 242; Write time: 1860 13:30:14 INFO - TinderboxPrint: CPU usage
53.5% 13:30:14 INFO - TinderboxPrint: I/O read bytes / time
37,561,344 / 242 13:30:14 INFO - TinderboxPrint: I/O write bytes / time
662,895,104 / 1,860 13:30:14 INFO - TinderboxPrint: CPU idle
2,248.2 (46.5%) 13:30:14 INFO - TinderboxPrint: CPU system
967.8 (20.0%) 13:30:14 INFO - TinderboxPrint: CPU user
1,621.7 (33.5%) 13:30:14 INFO - TinderboxPrint: Swap in / out
400,965,632 / 0 13:30:14 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 355684864; Write bytes: 356706304; Read time: 27597; Write time: 720 13:30:14 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 36602880; Write bytes: 296030720; Read time: 229; Write time: 1102 13:30:14 INFO - Running post-run listener: _upload_blobber_files 13:30:14 INFO - Blob upload gear active. 13:30:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:30:14 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 13:30:14 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'] 13:30:14 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 13:30:14 INFO - (blobuploader) - INFO - Open directory for files ... 13:30:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:30:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:30:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:15 INFO - (blobuploader) - INFO - Done attempting. 13:30:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:30:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:30:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:16 INFO - (blobuploader) - INFO - Done attempting. 13:30:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:30:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:30:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:19 INFO - (blobuploader) - INFO - Done attempting. 13:30:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:30:19 INFO - Return code: 0 13:30:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:30:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:30:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14c2d0673e48bf982a18e5be0a8ac4afcfd288aaf7d5bb9cca678321b834933853c0c8b905025ffb7ed4c0663b6633a6f526bfab0713c9685641667487d9c547", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4f471ef7ea38b705df40d6472c7151a28ed72a989dc2f7f7cd09e4c8d33cd65e4ad277f6aeafb18c86fce1fb8642e0e2b9938fd9767ae0fd5348cc618083ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c96516387a12b08001e8361231c2b5f42aa3fab17b583b530451b35c47009be1e426d0c67f054dc5ecf7720aa34be52ad2574fa6640551d1d72d97054339d832"} 13:30:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:30:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:30:19 INFO - Contents: 13:30:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14c2d0673e48bf982a18e5be0a8ac4afcfd288aaf7d5bb9cca678321b834933853c0c8b905025ffb7ed4c0663b6633a6f526bfab0713c9685641667487d9c547", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4f471ef7ea38b705df40d6472c7151a28ed72a989dc2f7f7cd09e4c8d33cd65e4ad277f6aeafb18c86fce1fb8642e0e2b9938fd9767ae0fd5348cc618083ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c96516387a12b08001e8361231c2b5f42aa3fab17b583b530451b35c47009be1e426d0c67f054dc5ecf7720aa34be52ad2574fa6640551d1d72d97054339d832"} 13:30:19 INFO - Running post-run listener: copy_logs_to_upload_dir 13:30:19 INFO - Copying logs to upload dir... 13:30:19 INFO - mkdir: /builds/slave/test/build/upload/logs 13:30:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.023367 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-11 13:30:19.220263) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 13:30:19.223450) ========= 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.5TcEqhAY13/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.oFZOltciwK/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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/14c2d0673e48bf982a18e5be0a8ac4afcfd288aaf7d5bb9cca678321b834933853c0c8b905025ffb7ed4c0663b6633a6f526bfab0713c9685641667487d9c547", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4f471ef7ea38b705df40d6472c7151a28ed72a989dc2f7f7cd09e4c8d33cd65e4ad277f6aeafb18c86fce1fb8642e0e2b9938fd9767ae0fd5348cc618083ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c96516387a12b08001e8361231c2b5f42aa3fab17b583b530451b35c47009be1e426d0c67f054dc5ecf7720aa34be52ad2574fa6640551d1d72d97054339d832"} build_url:https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/K41N4gUNSt6jm77ZT6HXEA/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/14c2d0673e48bf982a18e5be0a8ac4afcfd288aaf7d5bb9cca678321b834933853c0c8b905025ffb7ed4c0663b6633a6f526bfab0713c9685641667487d9c547", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f4f471ef7ea38b705df40d6472c7151a28ed72a989dc2f7f7cd09e4c8d33cd65e4ad277f6aeafb18c86fce1fb8642e0e2b9938fd9767ae0fd5348cc618083ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c96516387a12b08001e8361231c2b5f42aa3fab17b583b530451b35c47009be1e426d0c67f054dc5ecf7720aa34be52ad2574fa6640551d1d72d97054339d832"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 13:30:19.256949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:30:19.257286) ========= 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.5TcEqhAY13/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.oFZOltciwK/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.005249 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 13:30:19.305950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 13:30:19.306281) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 13:30:19.306592) ========= ========= Total master_lag: 0.17 =========