builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0207 starttime: 1488983678.28 results: success (0) buildid: 20170308051923 builduid: 7462c4e2ace840a7b4b9360d7dd28a7b revision: becff35a0bed14b536bb0a141b0e9640e9cb063d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 06:34:38.276897) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 06:34:38.277340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2017-03-08 06:34:38.277607) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2017-03-08 06:34:41.142113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:34:41.142465) ========= 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.aNajRH44IU/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.U392S8i7w7/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 --2017-03-08 06:34:41-- 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% 18.3M=0.001s 2017-03-08 06:34:41 (18.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132797 ========= master_lag: 0.86 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:34:42.138260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:34:42.138591) ========= 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.aNajRH44IU/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.U392S8i7w7/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.028210 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:34:42.189561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 06:34:42.189917) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev becff35a0bed14b536bb0a141b0e9640e9cb063d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev becff35a0bed14b536bb0a141b0e9640e9cb063d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aNajRH44IU/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.U392S8i7w7/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 2017-03-08 06:34:42,302 truncating revision to first 12 chars 2017-03-08 06:34:42,302 Setting DEBUG logging. 2017-03-08 06:34:42,302 attempt 1/10 2017-03-08 06:34:42,302 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/becff35a0bed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 06:34:43,826 unpacking tar archive at: mozilla-central-becff35a0bed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.793782 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 06:34:44.011719) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 06:34:44.012067) ========= script_repo_revision: becff35a0bed14b536bb0a141b0e9640e9cb063d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 06:34:44.012463) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 06:34:44.012748) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 06:34:44.041686) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-08 06:34:44.042144) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aNajRH44IU/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.U392S8i7w7/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:34:44 INFO - MultiFileLogger online at 20170308 06:34:44 in /builds/slave/test 06:34:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:34:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:34:44 INFO - {'append_to_log': False, 06:34:44 INFO - 'base_work_dir': '/builds/slave/test', 06:34:44 INFO - 'blob_upload_branch': 'Firefox', 06:34:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:34:44 INFO - 'branch': 'Firefox', 06:34:44 INFO - 'buildbot_json_path': 'buildprops.json', 06:34:44 INFO - 'config_files': ('talos/mac_config.py',), 06:34:44 INFO - 'default_actions': ('clobber', 06:34:44 INFO - 'read-buildbot-config', 06:34:44 INFO - 'download-and-extract', 06:34:44 INFO - 'populate-webroot', 06:34:44 INFO - 'create-virtualenv', 06:34:44 INFO - 'install', 06:34:44 INFO - 'run-tests'), 06:34:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:34:44 INFO - 'download_minidump_stackwalk': True, 06:34:44 INFO - 'download_symbols': 'ondemand', 06:34:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:34:44 INFO - 'tooltool.py': '/tools/tooltool.py', 06:34:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:34:44 INFO - '/tools/misc-python/virtualenv.py')}, 06:34:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:34:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:34:44 INFO - 'gecko_profile': False, 06:34:44 INFO - 'gecko_profile_interval': 0, 06:34:44 INFO - 'installer_path': 'installer.exe', 06:34:44 INFO - 'log_level': 'info', 06:34:44 INFO - 'log_name': 'talos', 06:34:44 INFO - 'log_to_console': True, 06:34:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:34:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:34:44 INFO - 'opt_config_files': (), 06:34:44 INFO - 'pip_index': False, 06:34:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:34:44 INFO - 'cmd': ('bash', 06:34:44 INFO - '-c', 06:34:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:34:44 INFO - 'enabled': True, 06:34:44 INFO - 'halt_on_failure': False, 06:34:44 INFO - 'name': 'check_screen_resolution'},), 06:34:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:34:44 INFO - 'cmd': ('bash', 06:34:44 INFO - '-c', 06:34:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:34:44 INFO - 'enabled': True, 06:34:44 INFO - 'halt_on_failure': False, 06:34:44 INFO - 'name': 'check_screen_resolution'},), 06:34:44 INFO - 'run_cmd_checks_enabled': True, 06:34:44 INFO - 'suite': 'dromaeojs', 06:34:44 INFO - 'system_bits': '32', 06:34:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:34:44 INFO - 'title': 't-yosemite-r7-0207', 06:34:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:34:44 INFO - 'use_talos_json': True, 06:34:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:34:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:34:44 INFO - 'work_dir': 'build'} 06:34:44 INFO - [mozharness: 2017-03-08 14:34:44.256253Z] Running clobber step. 06:34:44 INFO - Running pre-action listener: _resource_record_pre_action 06:34:44 INFO - Running main action method: clobber 06:34:44 INFO - rmtree: /builds/slave/test/build 06:34:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:34:46 INFO - Running post-action listener: _resource_record_post_action 06:34:46 INFO - [mozharness: 2017-03-08 14:34:46.741172Z] Finished clobber step (success) 06:34:46 INFO - [mozharness: 2017-03-08 14:34:46.741303Z] Running read-buildbot-config step. 06:34:46 INFO - Running pre-action listener: _resource_record_pre_action 06:34:46 INFO - Running main action method: read_buildbot_config 06:34:46 INFO - Using buildbot properties: 06:34:46 INFO - { 06:34:46 INFO - "project": "", 06:34:46 INFO - "product": "firefox", 06:34:46 INFO - "script_repo_revision": "production", 06:34:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:34:46 INFO - "repository": "", 06:34:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:34:46 INFO - "buildid": "20170308051923", 06:34:46 INFO - "pgo_build": "False", 06:34:46 INFO - "basedir": "/builds/slave/test", 06:34:46 INFO - "buildnumber": 13, 06:34:46 INFO - "slavename": "t-yosemite-r7-0207", 06:34:46 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:34:46 INFO - "platform": "yosemite_r7", 06:34:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:34:46 INFO - "branch": "mozilla-central", 06:34:46 INFO - "repo_path": "mozilla-central", 06:34:46 INFO - "revision": "becff35a0bed14b536bb0a141b0e9640e9cb063d", 06:34:46 INFO - "stage_platform": "macosx64", 06:34:46 INFO - "builduid": "7462c4e2ace840a7b4b9360d7dd28a7b", 06:34:46 INFO - "slavebuilddir": "test" 06:34:46 INFO - } 06:34:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 06:34:46 INFO - Running post-action listener: _resource_record_post_action 06:34:46 INFO - [mozharness: 2017-03-08 14:34:46.744539Z] Finished read-buildbot-config step (success) 06:34:46 INFO - [mozharness: 2017-03-08 14:34:46.744639Z] Running download-and-extract step. 06:34:46 INFO - Running pre-action listener: _resource_record_pre_action 06:34:46 INFO - Running main action method: download_and_extract 06:34:46 INFO - mkdir: /builds/slave/test/build/tests 06:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:34:46 INFO - trying https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 06:34:46 INFO - Downloading https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 06:34:47 INFO - Downloaded 1199 bytes. 06:34:47 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:34:47 INFO - Using the following test package requirements: 06:34:47 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:34:47 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:34:47 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 06:34:47 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:34:47 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 06:34:47 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:34:47 INFO - u'jsshell-mac.zip'], 06:34:47 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:34:47 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 06:34:47 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:34:47 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:34:47 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 06:34:47 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:34:47 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 06:34:47 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:34:47 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 06:34:47 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:34:47 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 06:34:47 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:34:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:34:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:34:47 INFO - Fetch https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:34:48 INFO - Expected file size: 51785998 06:34:48 INFO - Obtained file size: 51785998 06:35:04 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:35:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:35:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:35:04 INFO - Fetch https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:35:06 INFO - Expected file size: 51785998 06:35:06 INFO - Obtained file size: 51785998 06:35:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 06:35:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:35:21 INFO - Fetch https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 06:35:23 INFO - Expected file size: 14404424 06:35:23 INFO - Obtained file size: 14404424 06:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:23 INFO - trying https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:35:23 INFO - Downloading https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 06:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 06:35:25 INFO - Downloaded 74926864 bytes. 06:35:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:35:25 INFO - mkdir: /builds/slave/test/properties 06:35:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:35:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:35:25 INFO - Contents: 06:35:25 INFO - build_url:https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:35:27 INFO - Running post-action listener: _resource_record_post_action 06:35:27 INFO - Running post-action listener: set_extra_try_arguments 06:35:27 INFO - [mozharness: 2017-03-08 14:35:27.473628Z] Finished download-and-extract step (success) 06:35:27 INFO - [mozharness: 2017-03-08 14:35:27.473794Z] Running populate-webroot step. 06:35:27 INFO - Running pre-action listener: _resource_record_pre_action 06:35:27 INFO - Running main action method: populate_webroot 06:35:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:35:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:35:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:35:27 INFO - '--tppagecycles', 06:35:27 INFO - '7'], 06:35:27 INFO - 'tests': ['tsvgm']}}, 06:35:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:35:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:35:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:35:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:35:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:35:27 INFO - 'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:35:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:35:27 INFO - 'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['damp', 'tps']}, 06:35:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:35:27 INFO - 'tests': ['damp', 'tps']}, 06:35:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['dromaeo_dom']}, 06:35:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:35:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['basic_compositor_video']}, 06:35:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:35:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['a11yr', 06:35:27 INFO - 'ts_paint', 06:35:27 INFO - 'tpaint', 06:35:27 INFO - 'sessionrestore', 06:35:27 INFO - 'sessionrestore_no_auto_restore', 06:35:27 INFO - 'tabpaint']}, 06:35:27 INFO - 'other-e10s': {'tests': ['a11yr', 06:35:27 INFO - 'ts_paint', 06:35:27 INFO - 'tpaint', 06:35:27 INFO - 'sessionrestore', 06:35:27 INFO - 'sessionrestore_no_auto_restore', 06:35:27 INFO - 'tabpaint']}, 06:35:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:35:27 INFO - 'ts_paint', 06:35:27 INFO - 'tpaint', 06:35:27 INFO - 'sessionrestore', 06:35:27 INFO - 'sessionrestore_no_auto_restore', 06:35:27 INFO - 'tabpaint']}, 06:35:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:35:27 INFO - 'ts_paint', 06:35:27 INFO - 'tpaint', 06:35:27 INFO - 'sessionrestore', 06:35:27 INFO - 'sessionrestore_no_auto_restore', 06:35:27 INFO - 'tabpaint']}, 06:35:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['a11yr', 06:35:27 INFO - 'ts_paint', 06:35:27 INFO - 'tpaint', 06:35:27 INFO - 'sessionrestore', 06:35:27 INFO - 'sessionrestore_no_auto_restore', 06:35:27 INFO - 'tabpaint']}, 06:35:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['a11yr', 06:35:27 INFO - 'ts_paint', 06:35:27 INFO - 'tpaint', 06:35:27 INFO - 'sessionrestore', 06:35:27 INFO - 'sessionrestore_no_auto_restore', 06:35:27 INFO - 'tabpaint']}, 06:35:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['tsvgx', 06:35:27 INFO - 'tsvgr_opacity', 06:35:27 INFO - 'tart', 06:35:27 INFO - 'tscrollx', 06:35:27 INFO - 'cart', 06:35:27 INFO - 'tsvg_static']}, 06:35:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:35:27 INFO - 'tsvgr_opacity', 06:35:27 INFO - 'tart', 06:35:27 INFO - 'tscrollx', 06:35:27 INFO - 'cart', 06:35:27 INFO - 'tsvg_static']}, 06:35:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:35:27 INFO - 'talos_options': ['--disable-e10s'], 06:35:27 INFO - 'tests': ['tp5o']}, 06:35:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:35:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:35:27 INFO - 'talos_options': ['--disable-e10s', 06:35:27 INFO - '--xperf_path', 06:35:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:27 INFO - 'tests': ['tp5n']}, 06:35:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:35:27 INFO - 'talos_options': ['--xperf_path', 06:35:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:27 INFO - 'tests': ['tp5n']}}, 06:35:27 INFO - 'talos.zip': {'path': '', 06:35:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:35:27 INFO - Running post-action listener: _resource_record_post_action 06:35:27 INFO - [mozharness: 2017-03-08 14:35:27.492346Z] Finished populate-webroot step (success) 06:35:27 INFO - [mozharness: 2017-03-08 14:35:27.492466Z] Running create-virtualenv step. 06:35:27 INFO - Running pre-action listener: _resource_record_pre_action 06:35:27 INFO - Running main action method: create_virtualenv 06:35:27 INFO - Creating virtualenv /builds/slave/test/build/venv 06:35:27 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 06:35:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:35:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:35:27 INFO - Using real prefix '/tools/python27' 06:35:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:35:28 INFO - Installing distribute.............................................................................................................................................................................................done. 06:35:31 INFO - Installing pip.................done. 06:35:31 INFO - Return code: 0 06:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:35:31 INFO - Reading from file tmpfile_stdout 06:35:31 INFO - Output received: 06:35:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:35:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:32 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 0x10bce4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8803d8f300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, '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.aNajRH44IU/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.U392S8i7w7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:35:32 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 06:35:32 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 06:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:32 INFO - 'HOME': '/Users/cltbld', 06:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:32 INFO - 'LOGNAME': 'cltbld', 06:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:32 INFO - 'MOZ_NO_REMOTE': '1', 06:35:32 INFO - 'NO_EM_RESTART': '1', 06:35:32 INFO - 'PAGER': '/bin/cat', 06:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:32 INFO - 'PWD': '/builds/slave/test', 06:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:32 INFO - 'SHELL': '/bin/bash', 06:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:35:32 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:32 INFO - 'USER': 'cltbld', 06:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:32 INFO - 'XPC_FLAGS': '0x0', 06:35:32 INFO - 'XPC_SERVICE_NAME': '0', 06:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:32 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 06:35:32 INFO - Cleaning up... 06:35:32 INFO - Return code: 0 06:35:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:35:32 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')]} 06:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:32 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')]} 06:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:32 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 0x10bce4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8803d8f300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, '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.aNajRH44IU/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.U392S8i7w7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:35:32 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 06:35:32 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 06:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:32 INFO - 'HOME': '/Users/cltbld', 06:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:32 INFO - 'LOGNAME': 'cltbld', 06:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:32 INFO - 'MOZ_NO_REMOTE': '1', 06:35:32 INFO - 'NO_EM_RESTART': '1', 06:35:32 INFO - 'PAGER': '/bin/cat', 06:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:32 INFO - 'PWD': '/builds/slave/test', 06:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:32 INFO - 'SHELL': '/bin/bash', 06:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:35:32 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:32 INFO - 'USER': 'cltbld', 06:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:32 INFO - 'XPC_FLAGS': '0x0', 06:35:32 INFO - 'XPC_SERVICE_NAME': '0', 06:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:33 INFO - Downloading/unpacking psutil>=3.1.1 06:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:35:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:37 INFO - Installing collected packages: psutil 06:35:37 INFO - Running setup.py install for psutil 06:35:37 INFO - building 'psutil._psutil_osx' extension 06:35:37 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 06:35:37 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 06:35:37 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 06:35:37 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 06:35:37 INFO - building 'psutil._psutil_posix' extension 06:35:37 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 06:35:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:35:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:35:38 INFO - ^ 06:35:38 INFO - 1 warning generated. 06:35:38 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 06:35:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:38 INFO - Successfully installed psutil 06:35:38 INFO - Cleaning up... 06:35:38 INFO - Return code: 0 06:35:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bce4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8803d8f300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, '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.aNajRH44IU/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.U392S8i7w7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:38 INFO - 'HOME': '/Users/cltbld', 06:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:38 INFO - 'LOGNAME': 'cltbld', 06:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:38 INFO - 'MOZ_NO_REMOTE': '1', 06:35:38 INFO - 'NO_EM_RESTART': '1', 06:35:38 INFO - 'PAGER': '/bin/cat', 06:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:38 INFO - 'PWD': '/builds/slave/test', 06:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:38 INFO - 'SHELL': '/bin/bash', 06:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:35:38 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:38 INFO - 'USER': 'cltbld', 06:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:38 INFO - 'XPC_FLAGS': '0x0', 06:35:38 INFO - 'XPC_SERVICE_NAME': '0', 06:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:35:38 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 06:35:38 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 06:35:38 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 06:35:38 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 06:35:38 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 06:35:38 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 06:35:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:35:41 INFO - Installing collected packages: mozsystemmonitor 06:35:41 INFO - Running setup.py install for mozsystemmonitor 06:35:41 INFO - Successfully installed mozsystemmonitor 06:35:41 INFO - Cleaning up... 06:35:41 INFO - Return code: 0 06:35:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:35: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')]} 06:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35: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')]} 06:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35: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', '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 0x10bce4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8803d8f300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, '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.aNajRH44IU/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.U392S8i7w7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:35: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:35: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 jsonschema==2.5.1 06:35:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:35:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:41 INFO - 'HOME': '/Users/cltbld', 06:35:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:41 INFO - 'LOGNAME': 'cltbld', 06:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:41 INFO - 'MOZ_NO_REMOTE': '1', 06:35:41 INFO - 'NO_EM_RESTART': '1', 06:35:41 INFO - 'PAGER': '/bin/cat', 06:35:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:41 INFO - 'PWD': '/builds/slave/test', 06:35:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:41 INFO - 'SHELL': '/bin/bash', 06:35:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:35:41 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:35:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:41 INFO - 'USER': 'cltbld', 06:35:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:41 INFO - 'XPC_FLAGS': '0x0', 06:35:41 INFO - 'XPC_SERVICE_NAME': '0', 06:35:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:41 INFO - Downloading/unpacking jsonschema==2.5.1 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:35:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35:44 INFO - Downloading functools32-3.2.3-2.tar.gz 06:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:35:44 INFO - warning: no files found matching '*.txt' 06:35:44 INFO - no previously-included directories found matching 'build' 06:35:44 INFO - no previously-included directories found matching 'dist' 06:35:44 INFO - no previously-included directories found matching '.git*' 06:35:44 INFO - Installing collected packages: jsonschema, functools32 06:35:44 INFO - Running setup.py install for functools32 06:35:44 INFO - warning: no files found matching '*.txt' 06:35:44 INFO - no previously-included directories found matching 'build' 06:35:44 INFO - no previously-included directories found matching 'dist' 06:35:44 INFO - no previously-included directories found matching '.git*' 06:35:44 INFO - Successfully installed jsonschema functools32 06:35:44 INFO - Cleaning up... 06:35:45 INFO - Return code: 0 06:35:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bce4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8803d8f300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, '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.aNajRH44IU/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.U392S8i7w7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:35:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:35:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:35:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:45 INFO - 'HOME': '/Users/cltbld', 06:35:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:45 INFO - 'LOGNAME': 'cltbld', 06:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:45 INFO - 'MOZ_NO_REMOTE': '1', 06:35:45 INFO - 'NO_EM_RESTART': '1', 06:35:45 INFO - 'PAGER': '/bin/cat', 06:35:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:45 INFO - 'PWD': '/builds/slave/test', 06:35:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:45 INFO - 'SHELL': '/bin/bash', 06:35:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:35:45 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:35:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:45 INFO - 'USER': 'cltbld', 06:35:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:45 INFO - 'XPC_FLAGS': '0x0', 06:35:45 INFO - 'XPC_SERVICE_NAME': '0', 06:35:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:35:45 INFO - Cleaning up... 06:35:45 INFO - Return code: 0 06:35:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bce4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8803d8f300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, '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.aNajRH44IU/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.U392S8i7w7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:35:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:35:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:35:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:45 INFO - 'HOME': '/Users/cltbld', 06:35:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:45 INFO - 'LOGNAME': 'cltbld', 06:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:45 INFO - 'MOZ_NO_REMOTE': '1', 06:35:45 INFO - 'NO_EM_RESTART': '1', 06:35:45 INFO - 'PAGER': '/bin/cat', 06:35:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:45 INFO - 'PWD': '/builds/slave/test', 06:35:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:45 INFO - 'SHELL': '/bin/bash', 06:35:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:35:45 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:35:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:45 INFO - 'USER': 'cltbld', 06:35:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:45 INFO - 'XPC_FLAGS': '0x0', 06:35:45 INFO - 'XPC_SERVICE_NAME': '0', 06:35:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:45 INFO - Downloading/unpacking blobuploader==1.2.4 06:35:45 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 06:35:45 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 06:35:45 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 06:35:45 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 06:35:45 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 06:35:45 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 06:35:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:35:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:35:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:35:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35:49 INFO - Downloading docopt-0.6.1.tar.gz 06:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:35:49 INFO - Installing collected packages: blobuploader, requests, docopt 06:35:49 INFO - Running setup.py install for blobuploader 06:35:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:35:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:35:49 INFO - Running setup.py install for requests 06:35:50 INFO - Running setup.py install for docopt 06:35:50 INFO - Successfully installed blobuploader requests docopt 06:35:50 INFO - Cleaning up... 06:35:50 INFO - Return code: 0 06:35:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:50 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 0x10bce4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8803d8f300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, '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.aNajRH44IU/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.U392S8i7w7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:35:50 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 06:35:50 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 06:35:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:35:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:50 INFO - 'HOME': '/Users/cltbld', 06:35:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:50 INFO - 'LOGNAME': 'cltbld', 06:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:50 INFO - 'MOZ_NO_REMOTE': '1', 06:35:50 INFO - 'NO_EM_RESTART': '1', 06:35:50 INFO - 'PAGER': '/bin/cat', 06:35:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:50 INFO - 'PWD': '/builds/slave/test', 06:35:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:50 INFO - 'SHELL': '/bin/bash', 06:35:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:35:50 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:35:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:50 INFO - 'USER': 'cltbld', 06:35:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:50 INFO - 'XPC_FLAGS': '0x0', 06:35:50 INFO - 'XPC_SERVICE_NAME': '0', 06:35:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-CbYT0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-DKtRgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:50 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-pZAKER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:51 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-lyrVYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:51 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-BuCs9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:51 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-PM5hA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:51 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-7gtkZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:51 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-dm37fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:51 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-BuVszn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:51 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-o5zmrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:51 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-BaHPFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:51 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-PgP7kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:51 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-AQXxUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-JwA2i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-mUx2ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-h2Ay55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:52 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-xq6L16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:35:52 INFO - Running setup.py install for manifestparser 06:35:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:35:52 INFO - Running setup.py install for mozcrash 06:35:52 INFO - Running setup.py install for mozdebug 06:35:52 INFO - Running setup.py install for mozdevice 06:35:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:35:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:35:53 INFO - Running setup.py install for mozfile 06:35:53 INFO - Running setup.py install for mozhttpd 06:35:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:35:53 INFO - Running setup.py install for mozinfo 06:35:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:35:53 INFO - Running setup.py install for mozInstall 06:35:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:35:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:35:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:35:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:35:53 INFO - Running setup.py install for mozleak 06:35:53 INFO - Running setup.py install for mozlog 06:35:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:35:54 INFO - Running setup.py install for moznetwork 06:35:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:35:54 INFO - Running setup.py install for mozprocess 06:35:54 INFO - Running setup.py install for mozprofile 06:35:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:35:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:35:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:35:54 INFO - Running setup.py install for mozrunner 06:35:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:35:54 INFO - Running setup.py install for mozscreenshot 06:35:54 INFO - Running setup.py install for moztest 06:35:54 INFO - Running setup.py install for mozversion 06:35:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:35:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:35:55 INFO - Cleaning up... 06:35:55 INFO - Return code: 0 06:35:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:55 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 0x10bce4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8803d8f300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, '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.aNajRH44IU/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.U392S8i7w7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:35:55 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 06:35:55 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 06:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:35:55 INFO - 'HOME': '/Users/cltbld', 06:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:35:55 INFO - 'LOGNAME': 'cltbld', 06:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:55 INFO - 'MOZ_NO_REMOTE': '1', 06:35:55 INFO - 'NO_EM_RESTART': '1', 06:35:55 INFO - 'PAGER': '/bin/cat', 06:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:55 INFO - 'PWD': '/builds/slave/test', 06:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:35:55 INFO - 'SHELL': '/bin/bash', 06:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:35:55 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:35:55 INFO - 'USER': 'cltbld', 06:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:55 INFO - 'XPC_FLAGS': '0x0', 06:35:55 INFO - 'XPC_SERVICE_NAME': '0', 06:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-UWUVJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:55 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)) 06:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-BXcGCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 06:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-ZuWZPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:55 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)) 06:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-djYHdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 06:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-1Qj1Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:55 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)) 06:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-2eDFOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:55 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)) 06:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:55 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-IqfnN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-x1Ewl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Pwdwmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-wD4TBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-VvQxxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-zaR9Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-dgsvS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-fWHs13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-fJWf8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:56 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)) 06:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:56 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-jPuPPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 06:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:57 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-vuAm7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:57 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)) 06:35:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:35:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:35:57 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)) 06:35:57 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:35:57 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:35:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:35:57 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 06:35:57 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 06:35:57 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 06:35:57 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 06:35:57 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 06:35:57 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 06:35:59 INFO - Downloading blessings-1.6.tar.gz 06:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:35:59 INFO - Installing collected packages: blessings 06:35:59 INFO - Running setup.py install for blessings 06:36:00 INFO - Successfully installed blessings 06:36:00 INFO - Cleaning up... 06:36:00 INFO - Return code: 0 06:36:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:36:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:00 INFO - Reading from file tmpfile_stdout 06:36:00 INFO - Current package versions: 06:36:00 INFO - blessings == 1.6 06:36:00 INFO - blobuploader == 1.2.4 06:36:00 INFO - docopt == 0.6.1 06:36:00 INFO - functools32 == 3.2.3-2 06:36:00 INFO - jsonschema == 2.5.1 06:36:00 INFO - manifestparser == 1.1 06:36:00 INFO - mozInstall == 1.12 06:36:00 INFO - mozcrash == 1.0 06:36:00 INFO - mozdebug == 0.1 06:36:00 INFO - mozdevice == 0.49 06:36:00 INFO - mozfile == 1.2 06:36:00 INFO - mozhttpd == 0.7 06:36:00 INFO - mozinfo == 0.9 06:36:00 INFO - mozleak == 0.1 06:36:00 INFO - mozlog == 3.4 06:36:00 INFO - moznetwork == 0.27 06:36:00 INFO - mozprocess == 0.25 06:36:00 INFO - mozprofile == 0.28 06:36:00 INFO - mozrunner == 6.13 06:36:00 INFO - mozscreenshot == 0.1 06:36:00 INFO - mozsystemmonitor == 0.3 06:36:00 INFO - moztest == 0.8 06:36:00 INFO - mozversion == 1.4 06:36:00 INFO - psutil == 3.1.1 06:36:00 INFO - requests == 1.2.3 06:36:00 INFO - wsgiref == 0.1.2 06:36:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:00 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 0x10bce4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8803d8f300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, '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.aNajRH44IU/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.U392S8i7w7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:36:00 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 06:36:00 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 06:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:00 INFO - 'HOME': '/Users/cltbld', 06:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:00 INFO - 'LOGNAME': 'cltbld', 06:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:00 INFO - 'MOZ_NO_REMOTE': '1', 06:36:00 INFO - 'NO_EM_RESTART': '1', 06:36:00 INFO - 'PAGER': '/bin/cat', 06:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:00 INFO - 'PWD': '/builds/slave/test', 06:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:00 INFO - 'SHELL': '/bin/bash', 06:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:36:00 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:00 INFO - 'USER': 'cltbld', 06:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:00 INFO - 'XPC_FLAGS': '0x0', 06:36:00 INFO - 'XPC_SERVICE_NAME': '0', 06:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 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)) 06:36:00 INFO - Cleaning up... 06:36:00 INFO - Return code: 0 06:36:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:00 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 0x10bce4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bce7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8803d8f300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, '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.aNajRH44IU/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.U392S8i7w7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 06:36:00 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 06:36:00 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 06:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:00 INFO - 'HOME': '/Users/cltbld', 06:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:00 INFO - 'LOGNAME': 'cltbld', 06:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:00 INFO - 'MOZ_NO_REMOTE': '1', 06:36:00 INFO - 'NO_EM_RESTART': '1', 06:36:00 INFO - 'PAGER': '/bin/cat', 06:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:00 INFO - 'PWD': '/builds/slave/test', 06:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:00 INFO - 'SHELL': '/bin/bash', 06:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:36:00 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:00 INFO - 'USER': 'cltbld', 06:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:00 INFO - 'XPC_FLAGS': '0x0', 06:36:00 INFO - 'XPC_SERVICE_NAME': '0', 06:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:36:00 INFO - Cleaning up... 06:36:01 INFO - Return code: 0 06:36:01 INFO - Running post-action listener: _resource_record_post_action 06:36:01 INFO - Running post-action listener: _start_resource_monitoring 06:36:01 INFO - Starting resource monitoring. 06:36:01 INFO - [mozharness: 2017-03-08 14:36:01.037181Z] Finished create-virtualenv step (success) 06:36:01 INFO - [mozharness: 2017-03-08 14:36:01.038148Z] Running install step. 06:36:01 INFO - Running pre-action listener: _resource_record_pre_action 06:36:01 INFO - Running main action method: install 06:36:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:01 INFO - Reading from file tmpfile_stdout 06:36:01 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:01 INFO - Reading from file tmpfile_stdout 06:36:01 INFO - Output received: 06:36:01 INFO - Usage: mozinstall [options] installer 06:36:01 INFO - Options: 06:36:01 INFO - -h, --help show this help message and exit 06:36:01 INFO - -d DEST, --destination=DEST 06:36:01 INFO - Directory to install application into. [default: 06:36:01 INFO - "/builds/slave/test"] 06:36:01 INFO - --app=APP Application being installed. [default: firefox] 06:36:01 INFO - mkdir: /builds/slave/test/build/application 06:36:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:36:21 INFO - Reading from file tmpfile_stdout 06:36:21 INFO - Output received: 06:36:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:36:21 INFO - Running post-action listener: _resource_record_post_action 06:36:21 INFO - [mozharness: 2017-03-08 14:36:21.381040Z] Finished install step (success) 06:36:21 INFO - [mozharness: 2017-03-08 14:36:21.381200Z] Running run-tests step. 06:36:21 INFO - Running pre-action listener: _resource_record_pre_action 06:36:21 INFO - Running main action method: run_tests 06:36:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:36:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:36:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:36:21 INFO - 2017-03-08 06:36:21.395 screenresolution[1626:7363] starting screenresolution argv=screenresolution get 06:36:21 INFO - 2017-03-08 06:36:21.398 screenresolution[1626:7363] Display 0: 1600x1200x32@60 06:36:21 INFO - 2017-03-08 06:36:21.404 screenresolution[1627:7365] starting screenresolution argv=screenresolution list 06:36:21 INFO - Available Modes on Display 0 06:36:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:36:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:36:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:36:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:36:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:36:21 INFO - Intel Iris: 06:36:21 INFO - Chipset Model: Intel Iris 06:36:21 INFO - Type: GPU 06:36:21 INFO - Bus: Built-In 06:36:21 INFO - VRAM (Dynamic, Max): 1536 MB 06:36:21 INFO - Vendor: Intel (0x8086) 06:36:21 INFO - Device ID: 0x0a2e 06:36:21 INFO - Revision ID: 0x0009 06:36:21 INFO - Displays: 06:36:21 INFO - Display: 06:36:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:36:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:36:21 INFO - Display Serial Number: 1600x1200 60 06:36:21 INFO - Main Display: Yes 06:36:21 INFO - Mirror: Off 06:36:21 INFO - Online: Yes 06:36:21 INFO - Rotation: Supported 06:36:21 INFO - Return code: 0 06:36:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:36:21 INFO - Python 2.7.3 06:36:21 INFO - Return code: 0 06:36:21 INFO - grabbing minidump binary from tooltool 06:36:21 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')]} 06:36:21 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 0x10bac2d30>, '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 0x10b9e9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bab7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:36:21 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 06:36:21 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 06:36:21 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 06:36:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:36:21 INFO - Return code: 0 06:36:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:36:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:36:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:36:21 INFO - ENV: RUST_BACKTRACE is now 1 06:36:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:36:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:36:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 06:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0207 --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 06:36:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aNajRH44IU/Render', 06:36:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:21 INFO - 'HOME': '/Users/cltbld', 06:36:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:21 INFO - 'LOGNAME': 'cltbld', 06:36:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:36:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:21 INFO - 'MOZ_NO_REMOTE': '1', 06:36:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:36:21 INFO - 'NO_EM_RESTART': '1', 06:36:21 INFO - 'PAGER': '/bin/cat', 06:36:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:21 INFO - 'PWD': '/builds/slave/test', 06:36:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:36:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:21 INFO - 'RUST_BACKTRACE': '1', 06:36:21 INFO - 'SHELL': '/bin/bash', 06:36:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U392S8i7w7/Listeners', 06:36:21 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 06:36:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:21 INFO - 'USER': 'cltbld', 06:36:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:21 INFO - 'XPC_FLAGS': '0x0', 06:36:21 INFO - 'XPC_SERVICE_NAME': '0', 06:36:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 06:36:21 INFO - mozversion application_buildid: 20170308051923 06:36:21 INFO - mozversion application_changeset: becff35a0bed14b536bb0a141b0e9640e9cb063d 06:36:21 INFO - mozversion application_display_name: Nightly 06:36:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:36:21 INFO - mozversion application_name: Firefox 06:36:21 INFO - mozversion application_remotingname: firefox 06:36:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:36:21 INFO - mozversion application_vendor: Mozilla 06:36:21 INFO - mozversion application_version: 55.0a1 06:36:21 INFO - mozversion platform_buildid: 20170308051923 06:36:21 INFO - mozversion platform_changeset: becff35a0bed14b536bb0a141b0e9640e9cb063d 06:36:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:36:21 INFO - mozversion platform_version: 55.0a1 06:36:21 INFO - using testdate: 1488983781 06:36:21 INFO - actual date: 1488983781 06:36:21 INFO - starting webserver on 'localhost:49236' 06:36:21 INFO - SUITE-START | Running 2 tests 06:36:21 INFO - TEST-START | dromaeo_css 06:36:21 INFO - operating with platform_type : mac_ 06:36:21 INFO - Initialising browser for dromaeo_css test... 06:36:22 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpU0Isa1/profile http://localhost:49236/getInfo.html) 06:36:24 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 06:36:24 INFO - PROCESS | 1637 | colorDepth:24 06:36:24 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 06:36:24 INFO - PROCESS | 1637 | __metrics 06:36:24 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:36:24 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:36:25 INFO - TEST-INFO | 1637: exit 0 06:36:25 INFO - Browser initialized. 06:36:25 INFO - Running cycle 1/1 for dromaeo_css test... 06:36:25 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpU0Isa1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:36:37 INFO - PROCESS | 1639 | RSS: Main: 232263680 06:36:37 INFO - PROCESS | 1639 | 06:39:42 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 06:39:44 INFO - PROCESS | 1639 | RSS: Main: 403243008 06:39:44 INFO - PROCESS | 1639 | 06:41:27 INFO - PROCESS | 1639 | ************************* 06:41:27 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 06:41:27 INFO - PROCESS | 1639 | 06:41:27 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:41:27 INFO - PROCESS | 1639 | Full stack: 06:41:27 INFO - PROCESS | 1639 | ************************* 06:42:47 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 06:42:48 INFO - PROCESS | 1639 | RSS: Main: 364032000 06:42:48 INFO - PROCESS | 1639 | 06:45:50 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 06:45:51 INFO - PROCESS | 1639 | RSS: Main: 356065280 06:45:51 INFO - PROCESS | 1639 | 06:48:53 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 06:48:54 INFO - PROCESS | 1639 | RSS: Main: 353800192 06:48:54 INFO - PROCESS | 1639 | 06:51:58 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 06:51:59 INFO - PROCESS | 1639 | RSS: Main: 339329024 06:51:59 INFO - PROCESS | 1639 | 06:55:02 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 06:55:03 INFO - PROCESS | 1639 | RSS: Main: 520544256 06:55:03 INFO - PROCESS | 1639 | 06:55:03 INFO - PROCESS | 1639 | __start_tp_report 06:55:03 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 06:55:03 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 06:55:03 INFO - PROCESS | 1639 | |i|pagename|runs| 06:55:03 INFO - PROCESS | 1639 | |0;dojo.html;3335;3337.566116404867;3341.665833416658;3360.798352098873;3389.932201355973;5615.101583746601;5724.828255152342;5746.339170995331;5862.530997520204;5890.204822348982;5756.769729210837;5841.766329346831;5857.41425857414;5889.087191485316;5911.201987731666;5176.55999240065;5252.133397989337;5257.106291930362;5274.393444753845;5291.6031297652635;5340.359156901177;5347.946520534783;5401.27082843817;5401.891962160755;5428.45715428458;5158.174692049273;5215.58275337972;5254.238135470374;5255.08036093682;5265.631405801595;5235.633505654606;5241.50205730455;5243.134882744343;5253.789848406059;5267.315249017642;5170.508801663836;5192;5201.9479805201845;5218.478152184789;5221.138512145491;5753.597248192628;5761.337446193657;5769.653820770725;5770.278715160605;5778.133280007991;6199.411055949678;6218.129461875341;6221.564490485668;6233.501319894398;6261.624302541862;6153.8307721532765;6307.432331090178;6312.621242725451;6314.305426403092;6322.241331040259;5945.643261404286;5989.490893274077;6000.489958353502;6005.279366476051;6011.909821352683;6412.2822321362;6432.871342573122;6441.452476539453;6446.290908000116;6464.838379040468;6084.969575152096;6115.143879856823;6118.082287656798;6317.084022816666;6318.778842740574;6284;6305.243370795442;6324.71538780756;6326.304106548276;6334.3032266450655;6251.499880009588;6303.810885673437;6311.810645680637;6326.430621244018;6336.873262534724;6131.499004853578;6298.622082675054;6302.212223472066;6318.71565779541;6353.205849268841;4962.8511144665;5034.647574669738;5035.924461133086;5039.69761814285;5053.7220452875445;4430.069685366109;4462.955370446319;4505.526919673387;4535.7732113394195;4561.749103799323;5763.452472015152;5770.826875193751;5774.48029677331;5779.33537643168;5794.768209271666;5583.664980101207;6057.515398768088;6195.380461953769;6279.0267508535335;6279.717412716439;4573.359729637853;5736.770529178786;5845.941540584625;5974.133750606138;5982.641041537521;4729.810807567727;5528.695921724263;5577.247071645357;5593.8601534961135;5605.747741351649;6491.610503369813;6501.284858665637;6508.674566271668;6515.771947981798;6527.967360163168;6195.2255968004;6225.439710426083;6269.404406581368;6282.403171698681;6293.150424692608;5970.3432622412365;6314.778982735582;6321.209848768904;6328.588641738456;6371.522135839923;6314.589551679126;6325.05124231369;6357.554971151975;6363.3636636336;6371.331010243857;6195.752169913333;6368.872622547616;6376.808695739135;6386.329435409215;6425.293217746138;6084.178635884099;6264.404881536247;6269.028300613412;6282.654454005074;6288.402601752826;6042.546808989256;6142.754289828536;6157;6258.468030217483;6289.9371006291185;6139.815805525842;6149.354317796567;6154.261488621215;6166.876662466636;6168.35232300602;6284.402981716729;6289.08808222796;6293.496520278275;6296.150019747459;6299.622022678654;5776.884462310646;5806.477417032487;5938.673372964356;5954.851128721816;6044.697765111639 06:55:03 INFO - PROCESS | 1639 | |1;ext.html;725.1479511573899;773.20746235109;791.1969351108626;859.0121360435498;870.0690261420275;27246.18261452157;27622.30420828459;28475.57286640702;28500.429991400186;28537.42925141496;27509.762060707268;39747.80126099373;40301;42481.93795155123;42589.57410425895;8906.242969347597;9013.639454421815;9051.773705657379;9064.954675226647;9070.727878163632;8941.195292423681;9060.139286767779;9066.549352103664;9076.63693452261;9077.682281120162;7244.601546914918;7403.444741644371;10788.5684572617;10971.890281097207;11033.779324413506;10943.671689849318;10973.725656858562;10975.670729878037;10986;10989.670309890716;10561.471926403727;10631.681049568526;10641.787164256672;10643.361398316125;10668.199885008578;27286.5907011395;27687.72312276892;39476.80261598674;39802.80591582257;40050.59949400527;3796.2407518496134;3846.6922646188236;3854.1135538825947;3865.594112618163;3999.340108882031;27737.722622773716;28071.29821754452;28166.577501337495;28544;28551.714482855114;2591.883365248568;2969.020223326297;3119;3120.1419609607315;3147.087344670043;305102;305553;305583;305873;306429.46785266156;51226.74386628043;51247.48752512502;51321.71695707637;51342.74328628333;51357.743211283705;53630.73184634052;53694;53802.65493362619;53809.730951344995;53850;12517.812232816515;12606.684832879251;12641.620751377473;12646;12652.240865548096;11447.942760286145;11521.539138434537;11556.942215289038;11578.189526733047;11587.942060289644;10568;11205.159613028893;12254.877451225373;12364.319962402154;12391.75216495665;5670.744816483269;5797.971010145006;5833.883322333614;5843.29880414353;5848.473637372657;1091.3589114343308;1093.9015488606065;1114.7826173896012;1147.971300717472;1181.2085902445383;25428.872855635604;25881.74118258793;25926.22221333363;25950;26049.609255861178;1032.8863824979246;1175.4416652090188;1187.0262209519076;1231.1012960538858;1274.6813296675832;13244.271565063822;13681.589552313446;13706.177629342072;13736.587902362946;13797.965152613393;417371;417632;417646;418049;418782;54362.184567231525;54381.46520476157;54406.72796635992;54535.18423170552;54552.727236363564;1351.7431687979056;1372.3344178073626;1444.6893917807722;1445.2701385800315;1458.1469840143423;24549;25385;25515;25580;25601.48797024012;45321.77339113283;45419;45428.77285613551;45484.31773523334;45528.08943821039;402774;403752;404227;404347.9782601068;404512;32603.34793304073;33223.67434279577;33285.66714332825;33324.00139978925;33403.33193336168;34137;35157.648423515435;42717.35923961205;43781.34327985019;45748;32644;32682.673173268915;35546.822265888506;36661;37086;35129.47305790364;35319;36339.636603633626;36478.905632831054;36685;34867;35786.28427431489;36146.819265903505;36503.45244821277;36625.45061824022;30427.695723043373;31735.84132079325;31802.36395272128;31839.6816031846;31906.6809331913;23754.643680344463;23771.762282376956;24147.517049658556;24307.63538546888;24444.388890277885 06:55:03 INFO - PROCESS | 1639 | |2;jquery.html;380.90477380654835;381.1861675323184;392.41726036835297;393.9980300098499;407.22423782693977;13843.792343114848;15649.061056336614;20611.07250173742;20620.48448788781;20797.688034679453;21749.45626359342;22372.552548949054;22499.21252756154;22517.54964900701;22545.774542254574;6337.936620633793;6347.428731414172;6532.542722009462;6648;6689.93310066898;6601.603903765789;6626.933730662704;6682.732690692366;6686.43165330945;6707.02748101525;6395.20059992501;6588.868222635544;6614.50391220658;6649.50128740344;6649.800505984804;6308.3060863305;6488.28628850826;6613.239477460105;6687.431568316674;6715.160604924385;6371.617702937792;6376.234851817765;6378.362163783631;6382.92554919653;6391.233052033739;25737.227883163534;26236;26281.73718262812;26306.342341441617;26639.600405993926;2848.8788905095216;2853.2866783304175;2855.514562524376;2882.423515296949;2903.3177203357195;15997.20013999307;16332.265048072864;16339.101349425777;16635.41776037833;17327.82672173275;2017.9697304540443;2019.8687085339407;2028.6348457277684;2072.668373060303;2109.1879626343966;98065.54836129083;121743.39128304302;122183.3890830549;124363.37818310941;128989;20429.591408171753;20681.68977465339;20863.37409877706;20949.95250237482;21053.157873684882;34697.959061228205;34743.82628086894;34899;34924.65075349214;34954.30091398158;9936.453495057842;10066.848997265048;10277.588896444207;10310.123639490726;10462.738431539272;7064.1876184238445;7976.521408715495;8228.382871284557;8241.175882411831;8424.368172387096;9741;9843.901560984299;9956.950215248877;10003.549840257207;10006.949965250127;3581.943326718624;4155.750654960712;4232.957670423257;4276.379924910871;4295.3771703102875;1030.4590090202703;1078.8597482327248;1079.9082078023457;1117.1398023521842;1133.229404005268;21307.147714091574;22687.88656056709;22725.43186420353;22778.43053923632;22854.885725571265;1093.868735751715;1109.5395410904384;1122.1639878290725;1137.2891942535914;1145.770845830837;10017.749556261151;11074.39090850011;11093.944530277297;11969;12010.519579216909;667954;670776;677226;706303;707205;96034.51982740042;116365.83634163719;124624;125121.74878251283;127007;1318.7098838255567;1318.8351456067992;1321.9008574356963;1355.403622406138;1357.728454309142;16620.418285359956;18733.90633046826;19622.99905251039;19633.70549441788;19836.008199589673;48483.75758121187;48542.757286213346;49100.14397696351;49773.294207629166;51232;71617.64191179011;72591.63704181445;73039;73257;73448;8868.467891926504;9808.362456440309;11461.369624670722;11718.88281117178;11787.233829801036;10827.563798145355;12823;13048.934755326163;13143;13273.070885037954;10825.296355737168;11252.943735281271;11291.887081129084;11328;11357.103938495631;10026.649067282902;10074.496275186064;10081.596736130767;10368.896311036793;10382.065614094769;9689.9031009689;11280.830787538358;11429.942850285695;11494.137939654393;11503.252288601214;11370.147238957277;11402.828957565478;11755.941965223172;11813.881861181279;11951.76096478083;11040.503177356877;11113.555457781598;11420.371879546705;11434;11497.310161390009 06:55:03 INFO - PROCESS | 1639 | |3;mootools.html;1364.5838019404077;1551.5267843307793;1576.274913539771;1581.9920900395496;1589.1418633937672;7725.381969442446;9198.356115071947;9607.135357817804;9620.518974051296;9689.467079310634;9503.002184770603;10253.43606101664;10605.8409123863;10717.142628589714;10734.78530429393;2170.793774591415;2232.263353093483;2233.1625640384855;2238.339689791507;2245.5059886824874;2221.855579387343;2330.6387509935985;2361.89371478283;2365.2312998275543;2366.219147681261;1979.435860779678;2067.793220677935;2073.2847167727186;2249.752527222004;2343.121329501437;2311.2719493359623;2335.5795956727784;2335.976640233593;2342.5314937012495;2343.0627748900574;2246.135237933391;2304.873231972241;2328.685627440291;2330.557194133109;2330.568844763707;10793.784124317548;10934.781304373948;10943.726406839813;10949.616763413242;10951.397673127974;5639.6334238274385;5835.854103647443;5837.241158649391;5842.737076831553;5848.853778655525;3003.3843062172423;3093.412251672175;3515.455104458813;3557.9110522236892;3645.5989841117457;1144.891235332642;1200.8919197272287;1205.0841360565946;1248.7003119251315;1248.912576119672;14960.177190254532;15128.319225634763;15318.157501337422;15334.923325383414;15389.230538472919;4728.95962888164;4796.37647105874;4852.102361063215;4889.877753056202;4935.703857768545;12533.561325353568;12568.371581420892;12587.307698076695;12588.37058147089;12599.370031498573;5788;5789.536837053026;5797.565182611321;5798.304203495523;5799;5019.29729837823;5072.594192464594;5123.948760512421;5147.510986456281;5202.635815492955;3575.9272218334395;3888.5528164261473;3964.385520244309;4041.4948131483566;4041.9191616167514;1044.1385856668278;1118.1948996722347;1119.138263537072;1135.0307216978536;1139.3562637110172;747.4917056401699;763.5838468034934;789.8617741895146;794.1066300412036;797.3063434811751;6279.905801412982;6346.397092276226;6506.60960342381;6524.9673751630935;6539.8365040873405;946.2004606107828;954.9188318992964;972.1687956796978;988.8170688422665;996.257787947969;4049.6152865477734;4059.289624315733;4060.1067765091634;4171.666266698657;4186.979065104655;12953.417096230693;13133.408996595175;13181.077324587379;13487.595372138852;13502.662433439045;11920.556285961356;13371.53199638008;13395.062345635906;13402.798958015637;13405.798913016313;9659.9034009659;9923.404595724136;9932.056454636799;9946.80106397868;9956.203503719686;6313.210848643919;6442.130312407765;6468.964965605481;6499.1876015498065;6521.706523206372;9196.402233854778;11032.28290161137;12167.148299618942;12190.51237950472;12194.695132621755;10063.798724025624;11930.22453540517;12199.268043917393;12378.009759219061;12399.628011159679;8592.312614990911;8950.328725345755;8979.191872731486;9057.864132038156;9153.77115572116;9833.065858743408;10162.39025658463;10271.178305735373;10275.7431064224;10277;8457.238848503664;8827.911720882708;8913.286937044892;8953.328500362368;9112;8530.616122274636;8577.742667719978;8639.568021599021;8651.307895368229;8715.694950676696;7675.543825975634;7679.500832445873;7811.414143939113;7812.492188007761;7834.373250140089;5182.844514664566;5371.973140134274;5672.319321681424;5863.442972917736;5925.851903667364;5789.160571716993;5873.823785286449;6017.157597936205;6031.185789918305;6079.969694855075 06:55:03 INFO - PROCESS | 1639 | |4;prototype.html;298.2707280698693;363.42034455044194;371.1482148469263;385.38531042986426;386.3374313053113;4115.897102572437;4298.957010429895;4382;4811.446683631383;4850.151223535876;3663.578688450829;4485.631882275905;4593.093866045587;4740.525947405258;4801.951980480194;3386.64440233775;4120.958790412087;4271.807768650403;4283.550227226143;4376.330438432569;3418.350513402458;3611.512445819807;4149.647279981205;4246.405503229535;4291.527931927485;3571.6071232164572;3883.766834070421;4075.6943229257777;4133.3386658134705;4286.292761694317;3490.0053484756977;3882.669973052294;3981.5023122109737;4015.558288588253;4127.605988526662;3236.3527294541186;3284.080457471912;3527.5414196154593;3629.510016147839;3682.65014823594;3850.191459793447;4008.817398867341;4042.7170098093147;4367.082912588328;4774.045190961821;4139.296319625671;4184.476940382452;4240.893977650552;4736.242201247818;4737.620990320801;4833.589144922686;5010.749462526859;5038.39539255288;5067.797288108472;5163.122269214243;4076.266272071026;4098.446709694213;4199.144581684453;4265.637420819234;4278.4010238566625;4896.5837903777865;5146.6875946633745;5603.383627800979;5696.458836410535;5753.88492230153;3746.7189960752507;3778.5654649715634;3964.524257089168;4014.2172276406404;4114.485689288839;3864.343061679465;4128.91742165155;4146.730462519927;4157.896052598649;4163.417121602978;4568.812108851723;4755.857324280277;4787.18617834962;4803.3995750531185;4888.315635810989;4428.68999170055;5014.473480284591;5135.589152867761;5249.32547216942;5345.572354211654;1390.6731917999261;1407.9577612671637;1469.7060587882465;1494.745893198137;1507.9321430535651;1040.5681642118436;1052.3370276725614;1061.0662616897082;1089.9590890699362;1132.9037031852386;4321.157374312042;4726.692764970335;4889.755512224375;4908.386451693538;4908.901821963541;4360.934585981213;5180.218440538428;5314.867128321745;5425.674459532441;5453.291072160594;3994.9213712298097;4249.702520823513;4435.933460998088;4750.311204875343;4842.595647262325;2521.4957008598353;2689.542777727791;2695.0836715516816;2791.2463634818487;2837.5318072518216;4963.181075122637;5211.0578667022955;5253.343332083489;5343.774502704384;5370.516653501204;4912.975435122801;5217.8173763918085;5526.751296191601;5555.444455554412;5559.360673522597;4677.7193368398;5198.636095473281;5234.398044224887;5488.7530061147345;5491.148871924858;4603.5396460353695;4694.929576056294;5055.443901170942;5211.791528338824;5345.2249423832545;5280.498352656491;5284.550813180923;5291.550218231339;5306.681599104066;5326.520613144836;4550.613197878085;5070.340855688737;5108.335916330853;5255.737213139404;5502.202180683698;3674.228412033503;3898.200868821828;4317;4349.673774466991;4360.28055370873;4842.297866809364;5398.2982212312145;5411.891762164813;5418.9162167565855;5419.566434685295;4879.585235255043;5287.841364759063;5317.1492561190025;5318.228856815817;5338.172583249602;4550.68145229844;4694.929576056294;4839.830605928775;5249.711265880261;5257.8159764408065;4698.882527936829;4973.801047958041;5044.621653375938;5069.92395114081;5076.0863044652315;4703.905921881612;5253.395859476209;5262.473752624707;5313.123334649739;5336.866578335573;4090.747855454861;4913.4478039814785;5103.80060685746;5125.410577783603;5148.76830542619 06:55:03 INFO - PROCESS | 1639 | |5;yui.html;711.6732250294876;714.9571025738456;755.5466719968019;814.4705941138259;818.8853560501531;15227.390904363827;15921.442749503769;15934.964227325216;15951.68096638068;15989.440369587051;13926.164430134173;14290.785638215435;14433.494827681034;14438.989270751052;14776.926115369435;926.800737841364;961.6345788600357;964.6961207219739;966.2221911361352;969.5200875566604;913.968011119611;947.1286416496805;963.8457846744523;964.161179773598;969.4377261188529;1011.3982180602529;1014.2443879309924;1015;1015.2943704125636;1015.8323876560358;1001.9849702254472;1004.9397036177853;1006.2000709436016;1007.1741172238767;1007.808516381885;751.2937838431857;751.684292597105;754.294734423316;754.486948874765;757.4054367321681;15382.153981531012;15727.606809829846;15750.2124893756;15755.763663544942;16177.919110404491;13687.11033782801;13845.307734613229;14013.789793153112;14049;14303.427862885472;11727.589534366256;11787.410629468492;11861.110416718695;11974.922256996912;12214.694632634255;3625.4743062255825;3661.194537201838;3709.647583479592;3813.561440434358;3817.2365526894732;82565.17434825635;85668.7149692755;96641.5167924163;108607.45065888137;113408.86591134066;11488.19582629208;11537.538498459968;11754.70613234676;11755.529778808923;12077.57728479499;24043.918023688977;24631.01475940978;24846;24867.39953108681;24883.755812209318;7823.882641760378;7899.289063984269;8026.398020148512;8043.879341809878;8294.37792165578;4124.566920473307;4272.46594175728;4333.934990975138;4363.127374525045;4456.4652241730555;3187.3784612000436;3297.884574039945;3434.8969530914114;3531.4108651107103;3541.8760343387858;617.3857012272728;625.7309356976543;641.9101325814389;642.8553575445487;643.5559463969846;619.9101130336167;628.71707731521;634.194572892424;682.9248782633906;701.1761180612759;8887.600057997406;9643.421394716339;10068.295219334723;10102.39385636864;10140.543675534618;637.4581605635173;689.5931400473745;696.5646470955653;706.2725392845377;709.6416309763537;4875.19559272716;4877.463479017305;4914.413853245297;4919.36048313724;4960.429550601655;68500.6574967122;84718;94221.0577894226;100999.49500252599;101212;72072.55854882978;82733.93165170799;83745;83902;85629;57262.7136864313;70054;71895.92156117663;71897.85189120001;75105;8905.33210009239;9848.753781155528;10156.339837910513;10731.356118632906;11017.614383496539;49064.018719626125;50360.99999999854;50381.74809125931;50580;50717.23924141215;61277.03810323444;62316.37683623106;62790;63077;63849;12074.879251207727;12259.264444133381;12259.632211033684;12820.294883781482;12869.67825804325;14184.787228191379;14293.356798943865;14296.785548216993;14698.338574763948;15129.47046853399;13187.80218296707;13328.666783330495;14095.506657266946;14100.660437258444;14342.784858226927;12869.613911582668;13369.26469044212;13381.53164639233;13477;13850.65373365674;12977.675558111123;13007.368116693406;13352.465901363837;13357.065005449525;13869.09850859691;10600.628977985734;10796.385272224787;11064.736789927501;11153.609623663457;11169.664910052712;9807.656732014346;10214.233932455245;10735.036244735733;11189.832152517882;11202.15983801202 06:55:03 INFO - PROCESS | 1639 | __end_tp_report 06:55:03 INFO - PROCESS | 1639 | __start_cc_report 06:55:03 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1689 06:55:03 INFO - PROCESS | 1639 | __end_cc_report 06:55:03 INFO - PROCESS | 1639 | __startTimestamp1488984903194__endTimestamp 06:55:03 INFO - PROCESS | 1639 | 06:55:03 INFO - PROCESS | 1639 | ------- Summary: start ------- 06:55:03 INFO - PROCESS | 1639 | Number of tests: 6 06:55:03 INFO - PROCESS | 1639 | 06:55:03 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5817.65 Median:6044.70 stddev:666.49 (11.0%) stddev-sans-first:639.45 06:55:03 INFO - PROCESS | 1639 | Values: 3335.0 3337.6 3341.7 3360.8 3389.9 5615.1 5724.8 5746.3 5862.5 5890.2 5756.8 5841.8 5857.4 5889.1 5911.2 5176.6 5252.1 5257.1 5274.4 5291.6 5340.4 5347.9 5401.3 5401.9 5428.5 5158.2 5215.6 5254.2 5255.1 5265.6 5235.6 5241.5 5243.1 5253.8 5267.3 5170.5 5192.0 5201.9 5218.5 5221.1 5753.6 5761.3 5769.7 5770.3 5778.1 6199.4 6218.1 6221.6 6233.5 6261.6 6153.8 6307.4 6312.6 6314.3 6322.2 5945.6 5989.5 6000.5 6005.3 6011.9 6412.3 6432.9 6441.5 6446.3 6464.8 6085.0 6115.1 6118.1 6317.1 6318.8 6284.0 6305.2 6324.7 6326.3 6334.3 6251.5 6303.8 6311.8 6326.4 6336.9 6131.5 6298.6 6302.2 6318.7 6353.2 4962.9 5034.6 5035.9 5039.7 5053.7 4430.1 4463.0 4505.5 4535.8 4561.7 5763.5 5770.8 5774.5 5779.3 5794.8 5583.7 6057.5 6195.4 6279.0 6279.7 4573.4 5736.8 5845.9 5974.1 5982.6 4729.8 5528.7 5577.2 5593.9 5605.7 6491.6 6501.3 6508.7 6515.8 6528.0 6195.2 6225.4 6269.4 6282.4 6293.2 5970.3 6314.8 6321.2 6328.6 6371.5 6314.6 6325.1 6357.6 6363.4 6371.3 6195.8 6368.9 6376.8 6386.3 6425.3 6084.2 6264.4 6269.0 6282.7 6288.4 6042.5 6142.8 6157.0 6258.5 6289.9 6139.8 6149.4 6154.3 6166.9 6168.4 6284.4 6289.1 6293.5 6296.2 6299.6 5776.9 5806.5 5938.7 5954.9 6044.7 06:55:03 INFO - PROCESS | 1639 | 06:55:03 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:51811.29 Median:32255.01 stddev:100296.94 (310.9%) stddev-sans-first:100504.96 06:55:03 INFO - PROCESS | 1639 | Values: 725.1 773.2 791.2 859.0 870.1 27246.2 27622.3 28475.6 28500.4 28537.4 27509.8 39747.8 40301.0 42481.9 42589.6 8906.2 9013.6 9051.8 9065.0 9070.7 8941.2 9060.1 9066.5 9076.6 9077.7 7244.6 7403.4 10788.6 10971.9 11033.8 10943.7 10973.7 10975.7 10986.0 10989.7 10561.5 10631.7 10641.8 10643.4 10668.2 27286.6 27687.7 39476.8 39802.8 40050.6 3796.2 3846.7 3854.1 3865.6 3999.3 27737.7 28071.3 28166.6 28544.0 28551.7 2591.9 2969.0 3119.0 3120.1 3147.1 305102.0 305553.0 305583.0 305873.0 306429.5 51226.7 51247.5 51321.7 51342.7 51357.7 53630.7 53694.0 53802.7 53809.7 53850.0 12517.8 12606.7 12641.6 12646.0 12652.2 11447.9 11521.5 11556.9 11578.2 11587.9 10568.0 11205.2 12254.9 12364.3 12391.8 5670.7 5798.0 5833.9 5843.3 5848.5 1091.4 1093.9 1114.8 1148.0 1181.2 25428.9 25881.7 25926.2 25950.0 26049.6 1032.9 1175.4 1187.0 1231.1 1274.7 13244.3 13681.6 13706.2 13736.6 13798.0 417371.0 417632.0 417646.0 418049.0 418782.0 54362.2 54381.5 54406.7 54535.2 54552.7 1351.7 1372.3 1444.7 1445.3 1458.1 24549.0 25385.0 25515.0 25580.0 25601.5 45321.8 45419.0 45428.8 45484.3 45528.1 402774.0 403752.0 404227.0 404348.0 404512.0 32603.3 33223.7 33285.7 33324.0 33403.3 34137.0 35157.6 42717.4 43781.3 45748.0 32644.0 32682.7 35546.8 36661.0 37086.0 35129.5 35319.0 36339.6 36478.9 36685.0 34867.0 35786.3 36146.8 36503.5 36625.5 30427.7 31735.8 31802.4 31839.7 31906.7 23754.6 23771.8 24147.5 24307.6 24444.4 06:55:03 INFO - PROCESS | 1639 | 06:55:03 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:38589.00 Median:11708.17 stddev:113236.12 (967.2%) stddev-sans-first:113517.43 06:55:03 INFO - PROCESS | 1639 | Values: 380.9 381.2 392.4 394.0 407.2 13843.8 15649.1 20611.1 20620.5 20797.7 21749.5 22372.6 22499.2 22517.5 22545.8 6337.9 6347.4 6532.5 6648.0 6689.9 6601.6 6626.9 6682.7 6686.4 6707.0 6395.2 6588.9 6614.5 6649.5 6649.8 6308.3 6488.3 6613.2 6687.4 6715.2 6371.6 6376.2 6378.4 6382.9 6391.2 25737.2 26236.0 26281.7 26306.3 26639.6 2848.9 2853.3 2855.5 2882.4 2903.3 15997.2 16332.3 16339.1 16635.4 17327.8 2018.0 2019.9 2028.6 2072.7 2109.2 98065.5 121743.4 122183.4 124363.4 128989.0 20429.6 20681.7 20863.4 20950.0 21053.2 34698.0 34743.8 34899.0 34924.7 34954.3 9936.5 10066.8 10277.6 10310.1 10462.7 7064.2 7976.5 8228.4 8241.2 8424.4 9741.0 9843.9 9957.0 10003.5 10006.9 3581.9 4155.8 4233.0 4276.4 4295.4 1030.5 1078.9 1079.9 1117.1 1133.2 21307.1 22687.9 22725.4 22778.4 22854.9 1093.9 1109.5 1122.2 1137.3 1145.8 10017.7 11074.4 11093.9 11969.0 12010.5 667954.0 670776.0 677226.0 706303.0 707205.0 96034.5 116365.8 124624.0 125121.7 127007.0 1318.7 1318.8 1321.9 1355.4 1357.7 16620.4 18733.9 19623.0 19633.7 19836.0 48483.8 48542.8 49100.1 49773.3 51232.0 71617.6 72591.6 73039.0 73257.0 73448.0 8868.5 9808.4 11461.4 11718.9 11787.2 10827.6 12823.0 13048.9 13143.0 13273.1 10825.3 11252.9 11291.9 11328.0 11357.1 10026.6 10074.5 10081.6 10368.9 10382.1 9689.9 11280.8 11429.9 11494.1 11503.3 11370.1 11402.8 11755.9 11813.9 11951.8 11040.5 11113.6 11420.4 11434.0 11497.3 06:55:03 INFO - PROCESS | 1639 | 06:55:03 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:6563.69 Median:4041.71 stddev:4111.20 (101.7%) stddev-sans-first:4104.17 06:55:03 INFO - PROCESS | 1639 | Values: 1364.6 1551.5 1576.3 1582.0 1589.1 7725.4 9198.4 9607.1 9620.5 9689.5 9503.0 10253.4 10605.8 10717.1 10734.8 2170.8 2232.3 2233.2 2238.3 2245.5 2221.9 2330.6 2361.9 2365.2 2366.2 1979.4 2067.8 2073.3 2249.8 2343.1 2311.3 2335.6 2336.0 2342.5 2343.1 2246.1 2304.9 2328.7 2330.6 2330.6 10793.8 10934.8 10943.7 10949.6 10951.4 5639.6 5835.9 5837.2 5842.7 5848.9 3003.4 3093.4 3515.5 3557.9 3645.6 1144.9 1200.9 1205.1 1248.7 1248.9 14960.2 15128.3 15318.2 15334.9 15389.2 4729.0 4796.4 4852.1 4889.9 4935.7 12533.6 12568.4 12587.3 12588.4 12599.4 5788.0 5789.5 5797.6 5798.3 5799.0 5019.3 5072.6 5123.9 5147.5 5202.6 3575.9 3888.6 3964.4 4041.5 4041.9 1044.1 1118.2 1119.1 1135.0 1139.4 747.5 763.6 789.9 794.1 797.3 6279.9 6346.4 6506.6 6525.0 6539.8 946.2 954.9 972.2 988.8 996.3 4049.6 4059.3 4060.1 4171.7 4187.0 12953.4 13133.4 13181.1 13487.6 13502.7 11920.6 13371.5 13395.1 13402.8 13405.8 9659.9 9923.4 9932.1 9946.8 9956.2 6313.2 6442.1 6469.0 6499.2 6521.7 9196.4 11032.3 12167.1 12190.5 12194.7 10063.8 11930.2 12199.3 12378.0 12399.6 8592.3 8950.3 8979.2 9057.9 9153.8 9833.1 10162.4 10271.2 10275.7 10277.0 8457.2 8827.9 8913.3 8953.3 9112.0 8530.6 8577.7 8639.6 8651.3 8715.7 7675.5 7679.5 7811.4 7812.5 7834.4 5182.8 5372.0 5672.3 5863.4 5925.9 5789.2 5873.8 6017.2 6031.2 6080.0 06:55:03 INFO - PROCESS | 1639 | 06:55:03 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4308.66 Median:4694.93 stddev:1210.20 (25.8%) stddev-sans-first:1175.56 06:55:03 INFO - PROCESS | 1639 | Values: 298.3 363.4 371.1 385.4 386.3 4115.9 4299.0 4382.0 4811.4 4850.2 3663.6 4485.6 4593.1 4740.5 4802.0 3386.6 4121.0 4271.8 4283.6 4376.3 3418.4 3611.5 4149.6 4246.4 4291.5 3571.6 3883.8 4075.7 4133.3 4286.3 3490.0 3882.7 3981.5 4015.6 4127.6 3236.4 3284.1 3527.5 3629.5 3682.7 3850.2 4008.8 4042.7 4367.1 4774.0 4139.3 4184.5 4240.9 4736.2 4737.6 4833.6 5010.7 5038.4 5067.8 5163.1 4076.3 4098.4 4199.1 4265.6 4278.4 4896.6 5146.7 5603.4 5696.5 5753.9 3746.7 3778.6 3964.5 4014.2 4114.5 3864.3 4128.9 4146.7 4157.9 4163.4 4568.8 4755.9 4787.2 4803.4 4888.3 4428.7 5014.5 5135.6 5249.3 5345.6 1390.7 1408.0 1469.7 1494.7 1507.9 1040.6 1052.3 1061.1 1090.0 1132.9 4321.2 4726.7 4889.8 4908.4 4908.9 4360.9 5180.2 5314.9 5425.7 5453.3 3994.9 4249.7 4435.9 4750.3 4842.6 2521.5 2689.5 2695.1 2791.2 2837.5 4963.2 5211.1 5253.3 5343.8 5370.5 4913.0 5217.8 5526.8 5555.4 5559.4 4677.7 5198.6 5234.4 5488.8 5491.1 4603.5 4694.9 5055.4 5211.8 5345.2 5280.5 5284.6 5291.6 5306.7 5326.5 4550.6 5070.3 5108.3 5255.7 5502.2 3674.2 3898.2 4317.0 4349.7 4360.3 4842.3 5398.3 5411.9 5418.9 5419.6 4879.6 5287.8 5317.1 5318.2 5338.2 4550.7 4694.9 4839.8 5249.7 5257.8 4698.9 4973.8 5044.6 5069.9 5076.1 4703.9 5253.4 5262.5 5313.1 5336.9 4090.7 4913.4 5103.8 5125.4 5148.8 06:55:03 INFO - PROCESS | 1639 | 06:55:03 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:19444.97 Median:3366.39 stddev:26687.50 (792.8%) stddev-sans-first:26725.29 06:55:03 INFO - PROCESS | 1639 | Values: 711.7 715.0 755.5 814.5 818.9 15227.4 15921.4 15935.0 15951.7 15989.4 13926.2 14290.8 14433.5 14439.0 14776.9 926.8 961.6 964.7 966.2 969.5 914.0 947.1 963.8 964.2 969.4 1011.4 1014.2 1015.0 1015.3 1015.8 1002.0 1004.9 1006.2 1007.2 1007.8 751.3 751.7 754.3 754.5 757.4 15382.2 15727.6 15750.2 15755.8 16177.9 13687.1 13845.3 14013.8 14049.0 14303.4 11727.6 11787.4 11861.1 11974.9 12214.7 3625.5 3661.2 3709.6 3813.6 3817.2 82565.2 85668.7 96641.5 108607.5 113408.9 11488.2 11537.5 11754.7 11755.5 12077.6 24043.9 24631.0 24846.0 24867.4 24883.8 7823.9 7899.3 8026.4 8043.9 8294.4 4124.6 4272.5 4333.9 4363.1 4456.5 3187.4 3297.9 3434.9 3531.4 3541.9 617.4 625.7 641.9 642.9 643.6 619.9 628.7 634.2 682.9 701.2 8887.6 9643.4 10068.3 10102.4 10140.5 637.5 689.6 696.6 706.3 709.6 4875.2 4877.5 4914.4 4919.4 4960.4 68500.7 84718.0 94221.1 100999.5 101212.0 72072.6 82733.9 83745.0 83902.0 85629.0 57262.7 70054.0 71895.9 71897.9 75105.0 8905.3 9848.8 10156.3 10731.4 11017.6 49064.0 50361.0 50381.7 50580.0 50717.2 61277.0 62316.4 62790.0 63077.0 63849.0 12074.9 12259.3 12259.6 12820.3 12869.7 14184.8 14293.4 14296.8 14698.3 15129.5 13187.8 13328.7 14095.5 14100.7 14342.8 12869.6 13369.3 13381.5 13477.0 13850.7 12977.7 13007.4 13352.5 13357.1 13869.1 10600.6 10796.4 11064.7 11153.6 11169.7 9807.7 10214.2 10735.0 11189.8 11202.2 06:55:03 INFO - PROCESS | 1639 | -------- Summary: end -------- 06:55:03 INFO - PROCESS | 1639 | 06:55:03 INFO - TEST-INFO | 1639: exit 0 06:55:04 INFO - TEST-OK | dromaeo_css | took 1122018ms 06:55:04 INFO - TEST-START | kraken 06:55:04 INFO - operating with platform_type : mac_ 06:55:04 INFO - Initialising browser for kraken test... 06:55:04 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpjn28sF/profile http://localhost:49236/getInfo.html) 06:55:06 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 06:55:06 INFO - PROCESS | 1648 | colorDepth:24 06:55:06 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 06:55:06 INFO - PROCESS | 1648 | __metrics 06:55:06 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:55:06 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:55:07 INFO - TEST-INFO | 1648: exit 0 06:55:07 INFO - Browser initialized. 06:55:07 INFO - Running cycle 1/1 for kraken test... 06:55:07 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpjn28sF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:19 INFO - PROCESS | 1649 | RSS: Main: 233779200 06:55:19 INFO - PROCESS | 1649 | 06:55:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 06:55:23 INFO - PROCESS | 1649 | RSS: Main: 284516352 06:55:23 INFO - PROCESS | 1649 | 06:55:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 06:55:26 INFO - PROCESS | 1649 | RSS: Main: 286380032 06:55:26 INFO - PROCESS | 1649 | 06:55:29 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 06:55:30 INFO - PROCESS | 1649 | RSS: Main: 375865344 06:55:30 INFO - PROCESS | 1649 | 06:55:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 06:55:33 INFO - PROCESS | 1649 | RSS: Main: 278405120 06:55:33 INFO - PROCESS | 1649 | 06:55:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:55:35 INFO - PROCESS | 1649 | RSS: Main: 281546752 06:55:35 INFO - PROCESS | 1649 | 06:55:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 06:55:39 INFO - PROCESS | 1649 | RSS: Main: 323444736 06:55:39 INFO - PROCESS | 1649 | 06:55:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 06:55:43 INFO - PROCESS | 1649 | RSS: Main: 328794112 06:55:43 INFO - PROCESS | 1649 | 06:55:46 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 06:55:47 INFO - PROCESS | 1649 | RSS: Main: 326352896 06:55:47 INFO - PROCESS | 1649 | 06:55:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:55:49 INFO - PROCESS | 1649 | RSS: Main: 302874624 06:55:49 INFO - PROCESS | 1649 | 06:55:51 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:55:51 INFO - PROCESS | 1649 | RSS: Main: 307539968 06:55:51 INFO - PROCESS | 1649 | 06:55:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:55:54 INFO - PROCESS | 1649 | RSS: Main: 309137408 06:55:54 INFO - PROCESS | 1649 | 06:55:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:55:58 INFO - PROCESS | 1649 | RSS: Main: 328130560 06:55:58 INFO - PROCESS | 1649 | 06:56:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:02 INFO - PROCESS | 1649 | RSS: Main: 321982464 06:56:02 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 06:56:04 INFO - PROCESS | 1649 | RSS: Main: 366907392 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | __start_tp_report 06:56:04 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 06:56:04 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 06:56:04 INFO - PROCESS | 1649 | |i|pagename|runs| 06:56:04 INFO - PROCESS | 1649 | |0;ai-astar;117;117;117;116;117;126;172;147;117;114 06:56:04 INFO - PROCESS | 1649 | |1;audio-beat-detection;135;113;110;147;113;111;110;109;129;109 06:56:04 INFO - PROCESS | 1649 | |2;audio-dft;183;184;185;186;184;181;186;227;263;185 06:56:04 INFO - PROCESS | 1649 | |3;audio-fft;82;60;60;89;65;62;62;60;74;58 06:56:04 INFO - PROCESS | 1649 | |4;audio-oscillator;90;70;87;70;70;70;84;69;69;83 06:56:04 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;88;86;86;90;87;87;76;135;135;87 06:56:04 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;94;94;94;94;94;94;94;93;93 06:56:04 INFO - PROCESS | 1649 | |7;imaging-desaturate;84;85;97;132;84;89;101;84;83;85 06:56:04 INFO - PROCESS | 1649 | |8;json-parse-financial;64;63;63;60;61;60;82;95;61;61 06:56:04 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;59;61;57;63;60;59;57;58;58;58 06:56:04 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;88;91;108;106;101;87;86;87;87;92 06:56:04 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;142;142;138;141;136;140;140;140;177;159 06:56:04 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;222;230;205;223;179;168;171;174;172;173 06:56:04 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;67;67;65;67;66;66;66;71;80;83 06:56:04 INFO - PROCESS | 1649 | __end_tp_report 06:56:04 INFO - PROCESS | 1649 | __start_cc_report 06:56:04 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2115 06:56:04 INFO - PROCESS | 1649 | __end_cc_report 06:56:04 INFO - PROCESS | 1649 | __startTimestamp1488984964507__endTimestamp 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | ------- Summary: start ------- 06:56:04 INFO - PROCESS | 1649 | Number of tests: 14 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:126.00 Median:117.00 stddev:18.87 (16.1%) stddev-sans-first:19.74 06:56:04 INFO - PROCESS | 1649 | Values: 117.0 117.0 117.0 116.0 117.0 126.0 172.0 147.0 117.0 114.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:113.00 stddev:13.48 (11.9%) stddev-sans-first:12.93 06:56:04 INFO - PROCESS | 1649 | Values: 135.0 113.0 110.0 147.0 113.0 111.0 110.0 109.0 129.0 109.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:196.40 Median:185.50 stddev:27.02 (14.6%) stddev-sans-first:28.22 06:56:04 INFO - PROCESS | 1649 | Values: 183.0 184.0 185.0 186.0 184.0 181.0 186.0 227.0 263.0 185.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:67.20 Median:63.50 stddev:10.75 (16.9%) stddev-sans-first:9.98 06:56:04 INFO - PROCESS | 1649 | Values: 82.0 60.0 60.0 89.0 65.0 62.0 62.0 60.0 74.0 58.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:76.50 stddev:8.64 (11.3%) stddev-sans-first:7.58 06:56:04 INFO - PROCESS | 1649 | Values: 90.0 70.0 87.0 70.0 70.0 70.0 84.0 69.0 69.0 83.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:87.00 stddev:21.04 (24.2%) stddev-sans-first:22.13 06:56:04 INFO - PROCESS | 1649 | Values: 88.0 86.0 86.0 90.0 87.0 87.0 76.0 135.0 135.0 87.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:56:04 INFO - PROCESS | 1649 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 93.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:84.50 stddev:15.22 (18.0%) stddev-sans-first:15.84 06:56:04 INFO - PROCESS | 1649 | Values: 84.0 85.0 97.0 132.0 84.0 89.0 101.0 84.0 83.0 85.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:63.00 stddev:11.81 (18.8%) stddev-sans-first:12.48 06:56:04 INFO - PROCESS | 1649 | Values: 64.0 63.0 63.0 60.0 61.0 60.0 82.0 95.0 61.0 61.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:1.89 (3.2%) stddev-sans-first:2.00 06:56:04 INFO - PROCESS | 1649 | Values: 59.0 61.0 57.0 63.0 60.0 59.0 57.0 58.0 58.0 58.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:87.00 stddev:8.46 (9.7%) stddev-sans-first:8.75 06:56:04 INFO - PROCESS | 1649 | Values: 88.0 91.0 108.0 106.0 101.0 87.0 86.0 87.0 87.0 92.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:141.50 stddev:12.72 (9.0%) stddev-sans-first:13.43 06:56:04 INFO - PROCESS | 1649 | Values: 142.0 142.0 138.0 141.0 136.0 140.0 140.0 140.0 177.0 159.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.70 Median:192.00 stddev:25.26 (13.2%) stddev-sans-first:24.30 06:56:04 INFO - PROCESS | 1649 | Values: 222.0 230.0 205.0 223.0 179.0 168.0 171.0 174.0 172.0 173.0 06:56:04 INFO - PROCESS | 1649 | 06:56:04 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:67.00 stddev:6.41 (9.6%) stddev-sans-first:6.72 06:56:04 INFO - PROCESS | 1649 | Values: 67.0 67.0 65.0 67.0 66.0 66.0 66.0 71.0 80.0 83.0 06:56:04 INFO - PROCESS | 1649 | -------- Summary: end -------- 06:56:04 INFO - PROCESS | 1649 | 06:56:05 INFO - TEST-INFO | 1649: exit 0 06:56:05 INFO - TEST-OK | kraken | took 61428ms 06:56:05 INFO - SUITE-END | took 1183s 06:56:05 INFO - Completed test suite (00:19:43) 06:56:05 INFO - javascript benchmark 06:56:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7497.362571906919, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.0, 3337.566116404867, 3341.665833416658, 3360.798352098873, 3389.932201355973, 5615.101583746601, 5724.828255152342, 5746.339170995331, 5862.530997520204, 5890.204822348982, 5756.769729210837, 5841.766329346831, 5857.41425857414, 5889.087191485316, 5911.201987731666, 5176.55999240065, 5252.133397989337, 5257.106291930362, 5274.393444753845, 5291.6031297652635, 5340.359156901177, 5347.946520534783, 5401.27082843817, 5401.891962160755, 5428.45715428458, 5158.174692049273, 5215.58275337972, 5254.238135470374, 5255.08036093682, 5265.631405801595, 5235.633505654606, 5241.50205730455, 5243.134882744343, 5253.789848406059, 5267.315249017642, 5170.508801663836, 5192.0, 5201.9479805201845, 5218.478152184789, 5221.138512145491, 5753.597248192628, 5761.337446193657, 5769.653820770725, 5770.278715160605, 5778.133280007991, 6199.411055949678, 6218.129461875341, 6221.564490485668, 6233.501319894398, 6261.624302541862, 6153.8307721532765, 6307.432331090178, 6312.621242725451, 6314.305426403092, 6322.241331040259, 5945.643261404286, 5989.490893274077, 6000.489958353502, 6005.279366476051, 6011.909821352683, 6412.2822321362, 6432.871342573122, 6441.452476539453, 6446.290908000116, 6464.838379040468, 6084.969575152096, 6115.143879856823, 6118.082287656798, 6317.084022816666, 6318.778842740574, 6284.0, 6305.243370795442, 6324.71538780756, 6326.304106548276, 6334.3032266450655, 6251.499880009588, 6303.810885673437, 6311.810645680637, 6326.430621244018, 6336.873262534724, 6131.499004853578, 6298.622082675054, 6302.212223472066, 6318.71565779541, 6353.205849268841, 4962.8511144665, 5034.647574669738, 5035.924461133086, 5039.69761814285, 5053.7220452875445, 4430.069685366109, 4462.955370446319, 4505.526919673387, 4535.7732113394195, 4561.749103799323, 5763.452472015152, 5770.826875193751, 5774.48029677331, 5779.33537643168, 5794.768209271666, 5583.664980101207, 6057.515398768088, 6195.380461953769, 6279.0267508535335, 6279.717412716439, 4573.359729637853, 5736.770529178786, 5845.941540584625, 5974.133750606138, 5982.641041537521, 4729.810807567727, 5528.695921724263, 5577.247071645357, 5593.8601534961135, 5605.747741351649, 6491.610503369813, 6501.284858665637, 6508.674566271668, 6515.771947981798, 6527.967360163168, 6195.2255968004, 6225.439710426083, 6269.404406581368, 6282.403171698681, 6293.150424692608, 5970.3432622412365, 6314.778982735582, 6321.209848768904, 6328.588641738456, 6371.522135839923, 6314.589551679126, 6325.05124231369, 6357.554971151975, 6363.3636636336, 6371.331010243857, 6195.752169913333, 6368.872622547616, 6376.808695739135, 6386.329435409215, 6425.293217746138, 6084.178635884099, 6264.404881536247, 6269.028300613412, 6282.654454005074, 6288.402601752826, 6042.546808989256, 6142.754289828536, 6157.0, 6258.468030217483, 6289.9371006291185, 6139.815805525842, 6149.354317796567, 6154.261488621215, 6166.876662466636, 6168.35232300602, 6284.402981716729, 6289.08808222796, 6293.496520278275, 6296.150019747459, 6299.622022678654, 5776.884462310646, 5806.477417032487, 5938.673372964356, 5954.851128721816, 6044.697765111639], "value": 5773.935480750946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.1479511573899, 773.20746235109, 791.1969351108626, 859.0121360435498, 870.0690261420275, 27246.18261452157, 27622.30420828459, 28475.57286640702, 28500.429991400186, 28537.42925141496, 27509.762060707268, 39747.80126099373, 40301.0, 42481.93795155123, 42589.57410425895, 8906.242969347597, 9013.639454421815, 9051.773705657379, 9064.954675226647, 9070.727878163632, 8941.195292423681, 9060.139286767779, 9066.549352103664, 9076.63693452261, 9077.682281120162, 7244.601546914918, 7403.444741644371, 10788.5684572617, 10971.890281097207, 11033.779324413506, 10943.671689849318, 10973.725656858562, 10975.670729878037, 10986.0, 10989.670309890716, 10561.471926403727, 10631.681049568526, 10641.787164256672, 10643.361398316125, 10668.199885008578, 27286.5907011395, 27687.72312276892, 39476.80261598674, 39802.80591582257, 40050.59949400527, 3796.2407518496134, 3846.6922646188236, 3854.1135538825947, 3865.594112618163, 3999.340108882031, 27737.722622773716, 28071.29821754452, 28166.577501337495, 28544.0, 28551.714482855114, 2591.883365248568, 2969.020223326297, 3119.0, 3120.1419609607315, 3147.087344670043, 305102.0, 305553.0, 305583.0, 305873.0, 306429.46785266156, 51226.74386628043, 51247.48752512502, 51321.71695707637, 51342.74328628333, 51357.743211283705, 53630.73184634052, 53694.0, 53802.65493362619, 53809.730951344995, 53850.0, 12517.812232816515, 12606.684832879251, 12641.620751377473, 12646.0, 12652.240865548096, 11447.942760286145, 11521.539138434537, 11556.942215289038, 11578.189526733047, 11587.942060289644, 10568.0, 11205.159613028893, 12254.877451225373, 12364.319962402154, 12391.75216495665, 5670.744816483269, 5797.971010145006, 5833.883322333614, 5843.29880414353, 5848.473637372657, 1091.3589114343308, 1093.9015488606065, 1114.7826173896012, 1147.971300717472, 1181.2085902445383, 25428.872855635604, 25881.74118258793, 25926.22221333363, 25950.0, 26049.609255861178, 1032.8863824979246, 1175.4416652090188, 1187.0262209519076, 1231.1012960538858, 1274.6813296675832, 13244.271565063822, 13681.589552313446, 13706.177629342072, 13736.587902362946, 13797.965152613393, 417371.0, 417632.0, 417646.0, 418049.0, 418782.0, 54362.184567231525, 54381.46520476157, 54406.72796635992, 54535.18423170552, 54552.727236363564, 1351.7431687979056, 1372.3344178073626, 1444.6893917807722, 1445.2701385800315, 1458.1469840143423, 24549.0, 25385.0, 25515.0, 25580.0, 25601.48797024012, 45321.77339113283, 45419.0, 45428.77285613551, 45484.31773523334, 45528.08943821039, 402774.0, 403752.0, 404227.0, 404347.9782601068, 404512.0, 32603.34793304073, 33223.67434279577, 33285.66714332825, 33324.00139978925, 33403.33193336168, 34137.0, 35157.648423515435, 42717.35923961205, 43781.34327985019, 45748.0, 32644.0, 32682.673173268915, 35546.822265888506, 36661.0, 37086.0, 35129.47305790364, 35319.0, 36339.636603633626, 36478.905632831054, 36685.0, 34867.0, 35786.28427431489, 36146.819265903505, 36503.45244821277, 36625.45061824022, 30427.695723043373, 31735.84132079325, 31802.36395272128, 31839.6816031846, 31906.6809331913, 23754.643680344463, 23771.762282376956, 24147.517049658556, 24307.63538546888, 24444.388890277885], "value": 18223.75973782646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.90477380654835, 381.1861675323184, 392.41726036835297, 393.9980300098499, 407.22423782693977, 13843.792343114848, 15649.061056336614, 20611.07250173742, 20620.48448788781, 20797.688034679453, 21749.45626359342, 22372.552548949054, 22499.21252756154, 22517.54964900701, 22545.774542254574, 6337.936620633793, 6347.428731414172, 6532.542722009462, 6648.0, 6689.93310066898, 6601.603903765789, 6626.933730662704, 6682.732690692366, 6686.43165330945, 6707.02748101525, 6395.20059992501, 6588.868222635544, 6614.50391220658, 6649.50128740344, 6649.800505984804, 6308.3060863305, 6488.28628850826, 6613.239477460105, 6687.431568316674, 6715.160604924385, 6371.617702937792, 6376.234851817765, 6378.362163783631, 6382.92554919653, 6391.233052033739, 25737.227883163534, 26236.0, 26281.73718262812, 26306.342341441617, 26639.600405993926, 2848.8788905095216, 2853.2866783304175, 2855.514562524376, 2882.423515296949, 2903.3177203357195, 15997.20013999307, 16332.265048072864, 16339.101349425777, 16635.41776037833, 17327.82672173275, 2017.9697304540443, 2019.8687085339407, 2028.6348457277684, 2072.668373060303, 2109.1879626343966, 98065.54836129083, 121743.39128304302, 122183.3890830549, 124363.37818310941, 128989.0, 20429.591408171753, 20681.68977465339, 20863.37409877706, 20949.95250237482, 21053.157873684882, 34697.959061228205, 34743.82628086894, 34899.0, 34924.65075349214, 34954.30091398158, 9936.453495057842, 10066.848997265048, 10277.588896444207, 10310.123639490726, 10462.738431539272, 7064.1876184238445, 7976.521408715495, 8228.382871284557, 8241.175882411831, 8424.368172387096, 9741.0, 9843.901560984299, 9956.950215248877, 10003.549840257207, 10006.949965250127, 3581.943326718624, 4155.750654960712, 4232.957670423257, 4276.379924910871, 4295.3771703102875, 1030.4590090202703, 1078.8597482327248, 1079.9082078023457, 1117.1398023521842, 1133.229404005268, 21307.147714091574, 22687.88656056709, 22725.43186420353, 22778.43053923632, 22854.885725571265, 1093.868735751715, 1109.5395410904384, 1122.1639878290725, 1137.2891942535914, 1145.770845830837, 10017.749556261151, 11074.39090850011, 11093.944530277297, 11969.0, 12010.519579216909, 667954.0, 670776.0, 677226.0, 706303.0, 707205.0, 96034.51982740042, 116365.83634163719, 124624.0, 125121.74878251283, 127007.0, 1318.7098838255567, 1318.8351456067992, 1321.9008574356963, 1355.403622406138, 1357.728454309142, 16620.418285359956, 18733.90633046826, 19622.99905251039, 19633.70549441788, 19836.008199589673, 48483.75758121187, 48542.757286213346, 49100.14397696351, 49773.294207629166, 51232.0, 71617.64191179011, 72591.63704181445, 73039.0, 73257.0, 73448.0, 8868.467891926504, 9808.362456440309, 11461.369624670722, 11718.88281117178, 11787.233829801036, 10827.563798145355, 12823.0, 13048.934755326163, 13143.0, 13273.070885037954, 10825.296355737168, 11252.943735281271, 11291.887081129084, 11328.0, 11357.103938495631, 10026.649067282902, 10074.496275186064, 10081.596736130767, 10368.896311036793, 10382.065614094769, 9689.9031009689, 11280.830787538358, 11429.942850285695, 11494.137939654393, 11503.252288601214, 11370.147238957277, 11402.828957565478, 11755.941965223172, 11813.881861181279, 11951.76096478083, 11040.503177356877, 11113.555457781598, 11420.371879546705, 11434.0, 11497.310161390009], "value": 11259.358377990791, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.5838019404077, 1551.5267843307793, 1576.274913539771, 1581.9920900395496, 1589.1418633937672, 7725.381969442446, 9198.356115071947, 9607.135357817804, 9620.518974051296, 9689.467079310634, 9503.002184770603, 10253.43606101664, 10605.8409123863, 10717.142628589714, 10734.78530429393, 2170.793774591415, 2232.263353093483, 2233.1625640384855, 2238.339689791507, 2245.5059886824874, 2221.855579387343, 2330.6387509935985, 2361.89371478283, 2365.2312998275543, 2366.219147681261, 1979.435860779678, 2067.793220677935, 2073.2847167727186, 2249.752527222004, 2343.121329501437, 2311.2719493359623, 2335.5795956727784, 2335.976640233593, 2342.5314937012495, 2343.0627748900574, 2246.135237933391, 2304.873231972241, 2328.685627440291, 2330.557194133109, 2330.568844763707, 10793.784124317548, 10934.781304373948, 10943.726406839813, 10949.616763413242, 10951.397673127974, 5639.6334238274385, 5835.854103647443, 5837.241158649391, 5842.737076831553, 5848.853778655525, 3003.3843062172423, 3093.412251672175, 3515.455104458813, 3557.9110522236892, 3645.5989841117457, 1144.891235332642, 1200.8919197272287, 1205.0841360565946, 1248.7003119251315, 1248.912576119672, 14960.177190254532, 15128.319225634763, 15318.157501337422, 15334.923325383414, 15389.230538472919, 4728.95962888164, 4796.37647105874, 4852.102361063215, 4889.877753056202, 4935.703857768545, 12533.561325353568, 12568.371581420892, 12587.307698076695, 12588.37058147089, 12599.370031498573, 5788.0, 5789.536837053026, 5797.565182611321, 5798.304203495523, 5799.0, 5019.29729837823, 5072.594192464594, 5123.948760512421, 5147.510986456281, 5202.635815492955, 3575.9272218334395, 3888.5528164261473, 3964.385520244309, 4041.4948131483566, 4041.9191616167514, 1044.1385856668278, 1118.1948996722347, 1119.138263537072, 1135.0307216978536, 1139.3562637110172, 747.4917056401699, 763.5838468034934, 789.8617741895146, 794.1066300412036, 797.3063434811751, 6279.905801412982, 6346.397092276226, 6506.60960342381, 6524.9673751630935, 6539.8365040873405, 946.2004606107828, 954.9188318992964, 972.1687956796978, 988.8170688422665, 996.257787947969, 4049.6152865477734, 4059.289624315733, 4060.1067765091634, 4171.666266698657, 4186.979065104655, 12953.417096230693, 13133.408996595175, 13181.077324587379, 13487.595372138852, 13502.662433439045, 11920.556285961356, 13371.53199638008, 13395.062345635906, 13402.798958015637, 13405.798913016313, 9659.9034009659, 9923.404595724136, 9932.056454636799, 9946.80106397868, 9956.203503719686, 6313.210848643919, 6442.130312407765, 6468.964965605481, 6499.1876015498065, 6521.706523206372, 9196.402233854778, 11032.28290161137, 12167.148299618942, 12190.51237950472, 12194.695132621755, 10063.798724025624, 11930.22453540517, 12199.268043917393, 12378.009759219061, 12399.628011159679, 8592.312614990911, 8950.328725345755, 8979.191872731486, 9057.864132038156, 9153.77115572116, 9833.065858743408, 10162.39025658463, 10271.178305735373, 10275.7431064224, 10277.0, 8457.238848503664, 8827.911720882708, 8913.286937044892, 8953.328500362368, 9112.0, 8530.616122274636, 8577.742667719978, 8639.568021599021, 8651.307895368229, 8715.694950676696, 7675.543825975634, 7679.500832445873, 7811.414143939113, 7812.492188007761, 7834.373250140089, 5182.844514664566, 5371.973140134274, 5672.319321681424, 5863.442972917736, 5925.851903667364, 5789.160571716993, 5873.823785286449, 6017.157597936205, 6031.185789918305, 6079.969694855075], "value": 4997.428944034139, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.2707280698693, 363.42034455044194, 371.1482148469263, 385.38531042986426, 386.3374313053113, 4115.897102572437, 4298.957010429895, 4382.0, 4811.446683631383, 4850.151223535876, 3663.578688450829, 4485.631882275905, 4593.093866045587, 4740.525947405258, 4801.951980480194, 3386.64440233775, 4120.958790412087, 4271.807768650403, 4283.550227226143, 4376.330438432569, 3418.350513402458, 3611.512445819807, 4149.647279981205, 4246.405503229535, 4291.527931927485, 3571.6071232164572, 3883.766834070421, 4075.6943229257777, 4133.3386658134705, 4286.292761694317, 3490.0053484756977, 3882.669973052294, 3981.5023122109737, 4015.558288588253, 4127.605988526662, 3236.3527294541186, 3284.080457471912, 3527.5414196154593, 3629.510016147839, 3682.65014823594, 3850.191459793447, 4008.817398867341, 4042.7170098093147, 4367.082912588328, 4774.045190961821, 4139.296319625671, 4184.476940382452, 4240.893977650552, 4736.242201247818, 4737.620990320801, 4833.589144922686, 5010.749462526859, 5038.39539255288, 5067.797288108472, 5163.122269214243, 4076.266272071026, 4098.446709694213, 4199.144581684453, 4265.637420819234, 4278.4010238566625, 4896.5837903777865, 5146.6875946633745, 5603.383627800979, 5696.458836410535, 5753.88492230153, 3746.7189960752507, 3778.5654649715634, 3964.524257089168, 4014.2172276406404, 4114.485689288839, 3864.343061679465, 4128.91742165155, 4146.730462519927, 4157.896052598649, 4163.417121602978, 4568.812108851723, 4755.857324280277, 4787.18617834962, 4803.3995750531185, 4888.315635810989, 4428.68999170055, 5014.473480284591, 5135.589152867761, 5249.32547216942, 5345.572354211654, 1390.6731917999261, 1407.9577612671637, 1469.7060587882465, 1494.745893198137, 1507.9321430535651, 1040.5681642118436, 1052.3370276725614, 1061.0662616897082, 1089.9590890699362, 1132.9037031852386, 4321.157374312042, 4726.692764970335, 4889.755512224375, 4908.386451693538, 4908.901821963541, 4360.934585981213, 5180.218440538428, 5314.867128321745, 5425.674459532441, 5453.291072160594, 3994.9213712298097, 4249.702520823513, 4435.933460998088, 4750.311204875343, 4842.595647262325, 2521.4957008598353, 2689.542777727791, 2695.0836715516816, 2791.2463634818487, 2837.5318072518216, 4963.181075122637, 5211.0578667022955, 5253.343332083489, 5343.774502704384, 5370.516653501204, 4912.975435122801, 5217.8173763918085, 5526.751296191601, 5555.444455554412, 5559.360673522597, 4677.7193368398, 5198.636095473281, 5234.398044224887, 5488.7530061147345, 5491.148871924858, 4603.5396460353695, 4694.929576056294, 5055.443901170942, 5211.791528338824, 5345.2249423832545, 5280.498352656491, 5284.550813180923, 5291.550218231339, 5306.681599104066, 5326.520613144836, 4550.613197878085, 5070.340855688737, 5108.335916330853, 5255.737213139404, 5502.202180683698, 3674.228412033503, 3898.200868821828, 4317.0, 4349.673774466991, 4360.28055370873, 4842.297866809364, 5398.2982212312145, 5411.891762164813, 5418.9162167565855, 5419.566434685295, 4879.585235255043, 5287.841364759063, 5317.1492561190025, 5318.228856815817, 5338.172583249602, 4550.68145229844, 4694.929576056294, 4839.830605928775, 5249.711265880261, 5257.8159764408065, 4698.882527936829, 4973.801047958041, 5044.621653375938, 5069.92395114081, 5076.0863044652315, 4703.905921881612, 5253.395859476209, 5262.473752624707, 5313.123334649739, 5336.866578335573, 4090.747855454861, 4913.4478039814785, 5103.80060685746, 5125.410577783603, 5148.76830542619], "value": 3959.499111036733, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6732250294876, 714.9571025738456, 755.5466719968019, 814.4705941138259, 818.8853560501531, 15227.390904363827, 15921.442749503769, 15934.964227325216, 15951.68096638068, 15989.440369587051, 13926.164430134173, 14290.785638215435, 14433.494827681034, 14438.989270751052, 14776.926115369435, 926.800737841364, 961.6345788600357, 964.6961207219739, 966.2221911361352, 969.5200875566604, 913.968011119611, 947.1286416496805, 963.8457846744523, 964.161179773598, 969.4377261188529, 1011.3982180602529, 1014.2443879309924, 1015.0, 1015.2943704125636, 1015.8323876560358, 1001.9849702254472, 1004.9397036177853, 1006.2000709436016, 1007.1741172238767, 1007.808516381885, 751.2937838431857, 751.684292597105, 754.294734423316, 754.486948874765, 757.4054367321681, 15382.153981531012, 15727.606809829846, 15750.2124893756, 15755.763663544942, 16177.919110404491, 13687.11033782801, 13845.307734613229, 14013.789793153112, 14049.0, 14303.427862885472, 11727.589534366256, 11787.410629468492, 11861.110416718695, 11974.922256996912, 12214.694632634255, 3625.4743062255825, 3661.194537201838, 3709.647583479592, 3813.561440434358, 3817.2365526894732, 82565.17434825635, 85668.7149692755, 96641.5167924163, 108607.45065888137, 113408.86591134066, 11488.19582629208, 11537.538498459968, 11754.70613234676, 11755.529778808923, 12077.57728479499, 24043.918023688977, 24631.01475940978, 24846.0, 24867.39953108681, 24883.755812209318, 7823.882641760378, 7899.289063984269, 8026.398020148512, 8043.879341809878, 8294.37792165578, 4124.566920473307, 4272.46594175728, 4333.934990975138, 4363.127374525045, 4456.4652241730555, 3187.3784612000436, 3297.884574039945, 3434.8969530914114, 3531.4108651107103, 3541.8760343387858, 617.3857012272728, 625.7309356976543, 641.9101325814389, 642.8553575445487, 643.5559463969846, 619.9101130336167, 628.71707731521, 634.194572892424, 682.9248782633906, 701.1761180612759, 8887.600057997406, 9643.421394716339, 10068.295219334723, 10102.39385636864, 10140.543675534618, 637.4581605635173, 689.5931400473745, 696.5646470955653, 706.2725392845377, 709.6416309763537, 4875.19559272716, 4877.463479017305, 4914.413853245297, 4919.36048313724, 4960.429550601655, 68500.6574967122, 84718.0, 94221.0577894226, 100999.49500252599, 101212.0, 72072.55854882978, 82733.93165170799, 83745.0, 83902.0, 85629.0, 57262.7136864313, 70054.0, 71895.92156117663, 71897.85189120001, 75105.0, 8905.33210009239, 9848.753781155528, 10156.339837910513, 10731.356118632906, 11017.614383496539, 49064.018719626125, 50360.99999999854, 50381.74809125931, 50580.0, 50717.23924141215, 61277.03810323444, 62316.37683623106, 62790.0, 63077.0, 63849.0, 12074.879251207727, 12259.264444133381, 12259.632211033684, 12820.294883781482, 12869.67825804325, 14184.787228191379, 14293.356798943865, 14296.785548216993, 14698.338574763948, 15129.47046853399, 13187.80218296707, 13328.666783330495, 14095.506657266946, 14100.660437258444, 14342.784858226927, 12869.613911582668, 13369.26469044212, 13381.53164639233, 13477.0, 13850.65373365674, 12977.675558111123, 13007.368116693406, 13352.465901363837, 13357.065005449525, 13869.09850859691, 10600.628977985734, 10796.385272224787, 11064.736789927501, 11153.609623663457, 11169.664910052712, 9807.656732014346, 10214.233932455245, 10735.036244735733, 11189.832152517882, 11202.15983801202], "value": 7575.245056752259, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1492.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 126.0, 172.0, 147.0, 117.0, 114.0], "value": 126.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 113.0, 110.0, 147.0, 113.0, 111.0, 110.0, 109.0, 129.0, 109.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 185.0, 186.0, 184.0, 181.0, 186.0, 227.0, 263.0, 185.0], "value": 196.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 60.0, 89.0, 65.0, 62.0, 62.0, 60.0, 74.0, 58.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 87.0, 70.0, 70.0, 70.0, 84.0, 69.0, 69.0, 83.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 90.0, 87.0, 87.0, 76.0, 135.0, 135.0, 87.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 97.0, 132.0, 84.0, 89.0, 101.0, 84.0, 83.0, 85.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 60.0, 61.0, 60.0, 82.0, 95.0, 61.0, 61.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 57.0, 63.0, 60.0, 59.0, 57.0, 58.0, 58.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 108.0, 106.0, 101.0, 87.0, 86.0, 87.0, 87.0, 92.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 138.0, 141.0, 136.0, 140.0, 140.0, 140.0, 177.0, 159.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 230.0, 205.0, 223.0, 179.0, 168.0, 171.0, 174.0, 172.0, 173.0], "value": 191.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 67.0, 66.0, 66.0, 66.0, 71.0, 80.0, 83.0], "value": 69.8, "unit": "score"}]}]} 06:56:05 INFO - Return code: 0 06:56:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:56:05 ERROR - # TBPL SUCCESS # 06:56:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:56:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:56:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:56:05 INFO - 2017-03-08 06:56:05.805 screenresolution[1653:10068] starting screenresolution argv=screenresolution get 06:56:05 INFO - 2017-03-08 06:56:05.808 screenresolution[1653:10068] Display 0: 1600x1200x32@60 06:56:05 INFO - 2017-03-08 06:56:05.814 screenresolution[1654:10071] starting screenresolution argv=screenresolution list 06:56:05 INFO - Available Modes on Display 0 06:56:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:56:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:56:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:56:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:56:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:56:06 INFO - Intel Iris: 06:56:06 INFO - Chipset Model: Intel Iris 06:56:06 INFO - Type: GPU 06:56:06 INFO - Bus: Built-In 06:56:06 INFO - VRAM (Dynamic, Max): 1536 MB 06:56:06 INFO - Vendor: Intel (0x8086) 06:56:06 INFO - Device ID: 0x0a2e 06:56:06 INFO - Revision ID: 0x0009 06:56:06 INFO - Displays: 06:56:06 INFO - Display: 06:56:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:56:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:56:06 INFO - Display Serial Number: 1600x1200 60 06:56:06 INFO - Main Display: Yes 06:56:06 INFO - Mirror: Off 06:56:06 INFO - Online: Yes 06:56:06 INFO - Rotation: Supported 06:56:06 INFO - Return code: 0 06:56:06 INFO - Running post-action listener: _resource_record_post_action 06:56:06 INFO - [mozharness: 2017-03-08 14:56:06.068538Z] Finished run-tests step (success) 06:56:06 INFO - Running post-run listener: _resource_record_post_run 06:56:06 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 38032384; Write bytes: 514991104; Read time: 247; Write time: 1644 06:56:06 INFO - TinderboxPrint: CPU usage
54.0% 06:56:06 INFO - TinderboxPrint: I/O read bytes / time
38,032,384 / 247 06:56:06 INFO - TinderboxPrint: I/O write bytes / time
514,991,104 / 1,644 06:56:06 INFO - TinderboxPrint: CPU idle
2,214.7 (46.0%) 06:56:06 INFO - TinderboxPrint: CPU system
960.8 (19.9%) 06:56:06 INFO - TinderboxPrint: CPU user
1,642.2 (34.1%) 06:56:06 INFO - TinderboxPrint: Swap in / out
247,660,544 / 0 06:56:06 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207870464; Write bytes: 205056000; Read time: 15718; Write time: 445 06:56:06 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 35935232; Write bytes: 298888192; Read time: 226; Write time: 1163 06:56:06 INFO - Running post-run listener: _upload_blobber_files 06:56:06 INFO - Blob upload gear active. 06:56:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:56:06 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 06:56:06 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:56:06 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:56:06 INFO - (blobuploader) - INFO - Open directory for files ... 06:56:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:56:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:56:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:08 INFO - (blobuploader) - INFO - Done attempting. 06:56:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:56:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:56:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:09 INFO - (blobuploader) - INFO - Done attempting. 06:56:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:56:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:56:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:10 INFO - (blobuploader) - INFO - Done attempting. 06:56:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:56:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:12 INFO - (blobuploader) - INFO - Done attempting. 06:56:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:56:12 INFO - Return code: 0 06:56:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:56:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:56:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1de7069ac704dc146b36bed5345ede359239aeae054b6d1bb966c0e8e6442ae2148d78e7668c860f6e7cda9ea65773795ff2f6ee3acdc4910c4a15c4083b97e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363994d2bb20ce456b5cc9cbe3b430e5384e8bc7481c8ebe9295f861d9ef15c15c14bc6d06cb7dcf27186c6aefb3f21403bee96a21e9294dce14226dd8b51007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb31af953d415d9dced80e0836f083e9286739c8abc9f23cb40a6280085c67ca673dfbbdf7caa7662936fed0a79c10df9d0025987251515fc21142a3ff050665", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8f22dcebe647ad60ed428837497df77588bcfc692a26a040cab910ab8f6dbae3f8925673bc9bd1361b7cabd048c3130f0e58a70640cdc153eecbcd69b2ce6a2"} 06:56:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:56:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:56:12 INFO - Contents: 06:56:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1de7069ac704dc146b36bed5345ede359239aeae054b6d1bb966c0e8e6442ae2148d78e7668c860f6e7cda9ea65773795ff2f6ee3acdc4910c4a15c4083b97e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363994d2bb20ce456b5cc9cbe3b430e5384e8bc7481c8ebe9295f861d9ef15c15c14bc6d06cb7dcf27186c6aefb3f21403bee96a21e9294dce14226dd8b51007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb31af953d415d9dced80e0836f083e9286739c8abc9f23cb40a6280085c67ca673dfbbdf7caa7662936fed0a79c10df9d0025987251515fc21142a3ff050665", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8f22dcebe647ad60ed428837497df77588bcfc692a26a040cab910ab8f6dbae3f8925673bc9bd1361b7cabd048c3130f0e58a70640cdc153eecbcd69b2ce6a2"} 06:56:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:56:12 INFO - Copying logs to upload dir... 06:56:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:56:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.308863 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-08 06:56:12.393880) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 06:56:12.397436) ========= 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.aNajRH44IU/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.U392S8i7w7/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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/Firefox/sha512/e1de7069ac704dc146b36bed5345ede359239aeae054b6d1bb966c0e8e6442ae2148d78e7668c860f6e7cda9ea65773795ff2f6ee3acdc4910c4a15c4083b97e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363994d2bb20ce456b5cc9cbe3b430e5384e8bc7481c8ebe9295f861d9ef15c15c14bc6d06cb7dcf27186c6aefb3f21403bee96a21e9294dce14226dd8b51007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb31af953d415d9dced80e0836f083e9286739c8abc9f23cb40a6280085c67ca673dfbbdf7caa7662936fed0a79c10df9d0025987251515fc21142a3ff050665", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8f22dcebe647ad60ed428837497df77588bcfc692a26a040cab910ab8f6dbae3f8925673bc9bd1361b7cabd048c3130f0e58a70640cdc153eecbcd69b2ce6a2"} build_url:https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1de7069ac704dc146b36bed5345ede359239aeae054b6d1bb966c0e8e6442ae2148d78e7668c860f6e7cda9ea65773795ff2f6ee3acdc4910c4a15c4083b97e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363994d2bb20ce456b5cc9cbe3b430e5384e8bc7481c8ebe9295f861d9ef15c15c14bc6d06cb7dcf27186c6aefb3f21403bee96a21e9294dce14226dd8b51007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb31af953d415d9dced80e0836f083e9286739c8abc9f23cb40a6280085c67ca673dfbbdf7caa7662936fed0a79c10df9d0025987251515fc21142a3ff050665", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8f22dcebe647ad60ed428837497df77588bcfc692a26a040cab910ab8f6dbae3f8925673bc9bd1361b7cabd048c3130f0e58a70640cdc153eecbcd69b2ce6a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 06:56:12.431633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:56:12.431973) ========= 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.aNajRH44IU/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.U392S8i7w7/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.004575 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:56:12.480290) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 06:56:12.480607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 06:56:12.481073) ========= ========= Total master_lag: 1.02 =========