builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0105 starttime: 1469202902.7 results: success (0) buildid: 20160722080026 builduid: c29f9f9830d3452da61197b155ab2c91 revision: ff29f08b72c466b65dea5efa6f82f99add8f17ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:02.697833) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:02.698406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:02.698778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:02.752472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:02.752743) ========= 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.Pkea1jMpL1/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.WKOrGuTudK/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-22 08:55:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 135M=0s 2016-07-22 08:55:03 (135 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.723719 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:03.498020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:03.498298) ========= 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.Pkea1jMpL1/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.WKOrGuTudK/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.021144 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:03.547640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 08:55:03.547977) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff29f08b72c466b65dea5efa6f82f99add8f17ef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ff29f08b72c466b65dea5efa6f82f99add8f17ef --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Pkea1jMpL1/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.WKOrGuTudK/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-22 08:55:03,621 truncating revision to first 12 chars 2016-07-22 08:55:03,621 Setting DEBUG logging. 2016-07-22 08:55:03,621 attempt 1/10 2016-07-22 08:55:03,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff29f08b72c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 08:55:04,738 unpacking tar archive at: fx-team-ff29f08b72c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.378277 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 08:55:04.948219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:04.948536) ========= script_repo_revision: ff29f08b72c466b65dea5efa6f82f99add8f17ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:04.948925) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:04.949189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 08:55:04.967001) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 23 secs) (at 2016-07-22 08:55:04.967308) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Pkea1jMpL1/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.WKOrGuTudK/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 08:55:05 INFO - MultiFileLogger online at 20160722 08:55:05 in /builds/slave/test 08:55:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:55:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:05 INFO - {'append_to_log': False, 08:55:05 INFO - 'base_work_dir': '/builds/slave/test', 08:55:05 INFO - 'blob_upload_branch': 'Fx-Team', 08:55:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:05 INFO - 'branch': 'Fx-Team', 08:55:05 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:05 INFO - 'config_files': ('talos/mac_config.py',), 08:55:05 INFO - 'default_actions': ('clobber', 08:55:05 INFO - 'read-buildbot-config', 08:55:05 INFO - 'download-and-extract', 08:55:05 INFO - 'populate-webroot', 08:55:05 INFO - 'create-virtualenv', 08:55:05 INFO - 'install', 08:55:05 INFO - 'run-tests'), 08:55:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:05 INFO - 'download_minidump_stackwalk': True, 08:55:05 INFO - 'download_symbols': 'ondemand', 08:55:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:05 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:05 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:05 INFO - 'installer_path': 'installer.exe', 08:55:05 INFO - 'log_level': 'info', 08:55:05 INFO - 'log_name': 'talos', 08:55:05 INFO - 'log_to_console': True, 08:55:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:55:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:55:05 INFO - 'opt_config_files': (), 08:55:05 INFO - 'pip_index': False, 08:55:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:05 INFO - 'cmd': ('bash', 08:55:05 INFO - '-c', 08:55:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:05 INFO - 'enabled': True, 08:55:05 INFO - 'halt_on_failure': False, 08:55:05 INFO - 'name': 'check_screen_resolution'},), 08:55:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:05 INFO - 'cmd': ('bash', 08:55:05 INFO - '-c', 08:55:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:05 INFO - 'enabled': True, 08:55:05 INFO - 'halt_on_failure': False, 08:55:05 INFO - 'name': 'check_screen_resolution'},), 08:55:05 INFO - 'run_cmd_checks_enabled': True, 08:55:05 INFO - 'sps_profile': False, 08:55:05 INFO - 'sps_profile_interval': 0, 08:55:05 INFO - 'suite': 'dromaeojs-e10s', 08:55:05 INFO - 'system_bits': '32', 08:55:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:05 INFO - 'title': 't-yosemite-r7-0105', 08:55:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:05 INFO - 'use_talos_json': True, 08:55:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:05 INFO - 'work_dir': 'build'} 08:55:05 INFO - [mozharness: 2016-07-22 15:55:05.155567Z] Running clobber step. 08:55:05 INFO - Running pre-action listener: _resource_record_pre_action 08:55:05 INFO - Running main action method: clobber 08:55:05 INFO - rmtree: /builds/slave/test/build 08:55:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:07 INFO - Running post-action listener: _resource_record_post_action 08:55:07 INFO - [mozharness: 2016-07-22 15:55:07.115574Z] Finished clobber step (success) 08:55:07 INFO - [mozharness: 2016-07-22 15:55:07.115823Z] Running read-buildbot-config step. 08:55:07 INFO - Running pre-action listener: _resource_record_pre_action 08:55:07 INFO - Running main action method: read_buildbot_config 08:55:07 INFO - Using buildbot properties: 08:55:07 INFO - { 08:55:07 INFO - "project": "", 08:55:07 INFO - "product": "firefox", 08:55:07 INFO - "script_repo_revision": "production", 08:55:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:55:07 INFO - "repository": "", 08:55:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:55:07 INFO - "buildid": "20160722080026", 08:55:07 INFO - "pgo_build": "False", 08:55:07 INFO - "basedir": "/builds/slave/test", 08:55:07 INFO - "buildnumber": 8, 08:55:07 INFO - "slavename": "t-yosemite-r7-0105", 08:55:07 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:55:07 INFO - "platform": "yosemite_r7", 08:55:07 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:55:07 INFO - "branch": "fx-team", 08:55:07 INFO - "repo_path": "integration/fx-team", 08:55:07 INFO - "revision": "ff29f08b72c466b65dea5efa6f82f99add8f17ef", 08:55:07 INFO - "stage_platform": "macosx64", 08:55:07 INFO - "builduid": "c29f9f9830d3452da61197b155ab2c91", 08:55:07 INFO - "slavebuilddir": "test" 08:55:07 INFO - } 08:55:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 08:55:07 INFO - Running post-action listener: _resource_record_post_action 08:55:07 INFO - [mozharness: 2016-07-22 15:55:07.121684Z] Finished read-buildbot-config step (success) 08:55:07 INFO - [mozharness: 2016-07-22 15:55:07.121908Z] Running download-and-extract step. 08:55:07 INFO - Running pre-action listener: _resource_record_pre_action 08:55:07 INFO - Running main action method: download_and_extract 08:55:07 INFO - mkdir: /builds/slave/test/build/tests 08:55:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:07 INFO - https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:55:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 08:55:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 08:55:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 08:55:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 08:55:37 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 08:55:37 INFO - retry: attempt #1 caught exception: timed out 08:55:37 INFO - retry: Failed, sleeping 30 seconds before retrying 08:56:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #2 08:56:22 INFO - Downloaded 1199 bytes. 08:56:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 08:56:22 INFO - Using the following test package requirements: 08:56:22 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 08:56:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:56:22 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 08:56:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:56:22 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 08:56:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:56:22 INFO - u'jsshell-mac.zip'], 08:56:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:56:22 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 08:56:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 08:56:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:56:22 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 08:56:22 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:56:22 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 08:56:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:56:22 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 08:56:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:56:22 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 08:56:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:56:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:22 INFO - https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:56:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:56:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:56:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:56:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:56:23 INFO - Downloaded 18808563 bytes. 08:56:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:56:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:56:26 INFO - Return code: 0 08:56:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:26 INFO - https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:56:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:56:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:56:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:56:30 INFO - Downloaded 18808563 bytes. 08:56:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:56:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:56:34 INFO - Return code: 0 08:56:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:34 INFO - https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 08:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 08:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 08:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:56:35 INFO - Downloaded 14403289 bytes. 08:56:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:56:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:56:35 INFO - Return code: 0 08:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:35 INFO - https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 08:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 08:56:38 INFO - Downloaded 112896230 bytes. 08:56:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:56:38 INFO - mkdir: /builds/slave/test/properties 08:56:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:38 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:38 INFO - Contents: 08:56:38 INFO - build_url:https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:56:39 INFO - Running post-action listener: _resource_record_post_action 08:56:39 INFO - Running post-action listener: set_extra_try_arguments 08:56:39 INFO - [mozharness: 2016-07-22 15:56:39.297207Z] Finished download-and-extract step (success) 08:56:39 INFO - [mozharness: 2016-07-22 15:56:39.297352Z] Running populate-webroot step. 08:56:39 INFO - Running pre-action listener: _resource_record_pre_action 08:56:39 INFO - Running main action method: populate_webroot 08:56:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:56:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:56:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:56:39 INFO - '--tppagecycles', 08:56:39 INFO - '7'], 08:56:39 INFO - 'tests': ['tsvgm']}}, 08:56:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:56:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:56:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:56:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:56:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:39 INFO - 'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:39 INFO - 'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['damp', 'tps']}, 08:56:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:39 INFO - 'tests': ['damp', 'tps']}, 08:56:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['dromaeo_dom']}, 08:56:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['basic_compositor_video']}, 08:56:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:56:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['a11yr', 08:56:39 INFO - 'ts_paint', 08:56:39 INFO - 'tpaint', 08:56:39 INFO - 'sessionrestore', 08:56:39 INFO - 'sessionrestore_no_auto_restore', 08:56:39 INFO - 'tabpaint']}, 08:56:39 INFO - 'other-e10s': {'tests': ['a11yr', 08:56:39 INFO - 'ts_paint', 08:56:39 INFO - 'tpaint', 08:56:39 INFO - 'sessionrestore', 08:56:39 INFO - 'sessionrestore_no_auto_restore', 08:56:39 INFO - 'tabpaint']}, 08:56:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:56:39 INFO - 'ts_paint', 08:56:39 INFO - 'tpaint', 08:56:39 INFO - 'sessionrestore', 08:56:39 INFO - 'sessionrestore_no_auto_restore', 08:56:39 INFO - 'tabpaint']}, 08:56:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:56:39 INFO - 'ts_paint', 08:56:39 INFO - 'tpaint', 08:56:39 INFO - 'sessionrestore', 08:56:39 INFO - 'sessionrestore_no_auto_restore', 08:56:39 INFO - 'tabpaint']}, 08:56:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['a11yr', 08:56:39 INFO - 'ts_paint', 08:56:39 INFO - 'tpaint', 08:56:39 INFO - 'sessionrestore', 08:56:39 INFO - 'sessionrestore_no_auto_restore', 08:56:39 INFO - 'tabpaint']}, 08:56:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['a11yr', 08:56:39 INFO - 'ts_paint', 08:56:39 INFO - 'tpaint', 08:56:39 INFO - 'sessionrestore', 08:56:39 INFO - 'sessionrestore_no_auto_restore', 08:56:39 INFO - 'tabpaint']}, 08:56:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['tsvgx', 08:56:39 INFO - 'tsvgr_opacity', 08:56:39 INFO - 'tart', 08:56:39 INFO - 'tscrollx', 08:56:39 INFO - 'cart']}, 08:56:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:56:39 INFO - 'tsvgr_opacity', 08:56:39 INFO - 'tart', 08:56:39 INFO - 'tscrollx', 08:56:39 INFO - 'cart']}, 08:56:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:39 INFO - 'talos_options': ['--disable-e10s'], 08:56:39 INFO - 'tests': ['tp5o']}, 08:56:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:39 INFO - 'tests': ['tp5o']}, 08:56:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:39 INFO - 'talos_options': ['--disable-e10s', 08:56:39 INFO - '--xperf_path', 08:56:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:39 INFO - 'tests': ['tp5n']}, 08:56:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:39 INFO - 'talos_options': ['--xperf_path', 08:56:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:39 INFO - 'tests': ['tp5n']}}, 08:56:39 INFO - 'talos.zip': {'path': '', 08:56:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:56:39 INFO - Running post-action listener: _resource_record_post_action 08:56:39 INFO - [mozharness: 2016-07-22 15:56:39.316099Z] Finished populate-webroot step (success) 08:56:39 INFO - [mozharness: 2016-07-22 15:56:39.316236Z] Running create-virtualenv step. 08:56:39 INFO - Running pre-action listener: _resource_record_pre_action 08:56:39 INFO - Running main action method: create_virtualenv 08:56:39 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:39 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 08:56:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:56:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:39 INFO - Using real prefix '/tools/python27' 08:56:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:56:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:56:42 INFO - Installing pip.................done. 08:56:43 INFO - Return code: 0 08:56:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1080c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97324e3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108027d30>, '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 0x107d8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10801fb20>, '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.Pkea1jMpL1/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.WKOrGuTudK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 08:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pkea1jMpL1/Render', 08:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:43 INFO - 'HOME': '/Users/cltbld', 08:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:43 INFO - 'LOGNAME': 'cltbld', 08:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:43 INFO - 'MOZ_NO_REMOTE': '1', 08:56:43 INFO - 'NO_EM_RESTART': '1', 08:56:43 INFO - 'PAGER': '/bin/cat', 08:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:43 INFO - 'PWD': '/builds/slave/test', 08:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:43 INFO - 'SHELL': '/bin/bash', 08:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WKOrGuTudK/Listeners', 08:56:43 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 08:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:43 INFO - 'USER': 'cltbld', 08:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:43 INFO - 'XPC_FLAGS': '0x0', 08:56:43 INFO - 'XPC_SERVICE_NAME': '0', 08:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:43 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 08:56:43 INFO - Cleaning up... 08:56:43 INFO - Return code: 0 08:56:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1080c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97324e3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108027d30>, '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 0x107d8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10801fb20>, '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.Pkea1jMpL1/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.WKOrGuTudK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 08:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pkea1jMpL1/Render', 08:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:43 INFO - 'HOME': '/Users/cltbld', 08:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:43 INFO - 'LOGNAME': 'cltbld', 08:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:43 INFO - 'MOZ_NO_REMOTE': '1', 08:56:43 INFO - 'NO_EM_RESTART': '1', 08:56:43 INFO - 'PAGER': '/bin/cat', 08:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:43 INFO - 'PWD': '/builds/slave/test', 08:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:43 INFO - 'SHELL': '/bin/bash', 08:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WKOrGuTudK/Listeners', 08:56:43 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 08:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:43 INFO - 'USER': 'cltbld', 08:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:43 INFO - 'XPC_FLAGS': '0x0', 08:56:43 INFO - 'XPC_SERVICE_NAME': '0', 08:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:43 INFO - Downloading/unpacking psutil>=3.1.1 08:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:56:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:46 INFO - Installing collected packages: psutil 08:56:46 INFO - Running setup.py install for psutil 08:56:46 INFO - building 'psutil._psutil_osx' extension 08:56:46 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 08:56:46 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 08:56:46 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 08:56:46 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 08:56:46 INFO - building 'psutil._psutil_posix' extension 08:56:46 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 08:56:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:56:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:56:46 INFO - ^ 08:56:46 INFO - 1 warning generated. 08:56:46 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 08:56:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:46 INFO - Successfully installed psutil 08:56:46 INFO - Cleaning up... 08:56:47 INFO - Return code: 0 08:56:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:56:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:47 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 0x1080c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97324e3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108027d30>, '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 0x107d8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10801fb20>, '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.Pkea1jMpL1/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.WKOrGuTudK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 08:56:47 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 08:56:47 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 08:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pkea1jMpL1/Render', 08:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:47 INFO - 'HOME': '/Users/cltbld', 08:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:47 INFO - 'LOGNAME': 'cltbld', 08:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:47 INFO - 'MOZ_NO_REMOTE': '1', 08:56:47 INFO - 'NO_EM_RESTART': '1', 08:56:47 INFO - 'PAGER': '/bin/cat', 08:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:47 INFO - 'PWD': '/builds/slave/test', 08:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:47 INFO - 'SHELL': '/bin/bash', 08:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WKOrGuTudK/Listeners', 08:56:47 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 08:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:47 INFO - 'USER': 'cltbld', 08:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:47 INFO - 'XPC_FLAGS': '0x0', 08:56:47 INFO - 'XPC_SERVICE_NAME': '0', 08:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:56:49 INFO - Installing collected packages: mozsystemmonitor 08:56:49 INFO - Running setup.py install for mozsystemmonitor 08:56:49 INFO - Successfully installed mozsystemmonitor 08:56:49 INFO - Cleaning up... 08:56:50 INFO - Return code: 0 08:56:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1080c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97324e3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108027d30>, '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 0x107d8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10801fb20>, '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.Pkea1jMpL1/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.WKOrGuTudK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 08:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pkea1jMpL1/Render', 08:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:50 INFO - 'HOME': '/Users/cltbld', 08:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:50 INFO - 'LOGNAME': 'cltbld', 08:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:50 INFO - 'MOZ_NO_REMOTE': '1', 08:56:50 INFO - 'NO_EM_RESTART': '1', 08:56:50 INFO - 'PAGER': '/bin/cat', 08:56:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:50 INFO - 'PWD': '/builds/slave/test', 08:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:50 INFO - 'SHELL': '/bin/bash', 08:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WKOrGuTudK/Listeners', 08:56:50 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 08:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:50 INFO - 'USER': 'cltbld', 08:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:50 INFO - 'XPC_FLAGS': '0x0', 08:56:50 INFO - 'XPC_SERVICE_NAME': '0', 08:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:50 INFO - Downloading/unpacking jsonschema==2.5.1 08:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:56:52 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 08:56:52 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 08:56:52 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 08:56:52 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 08:56:52 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 08:56:52 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 08:56:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:53 INFO - warning: no files found matching '*.txt' 08:56:53 INFO - no previously-included directories found matching 'build' 08:56:53 INFO - no previously-included directories found matching 'dist' 08:56:53 INFO - no previously-included directories found matching '.git*' 08:56:53 INFO - Installing collected packages: jsonschema, functools32 08:56:53 INFO - Running setup.py install for functools32 08:56:53 INFO - warning: no files found matching '*.txt' 08:56:53 INFO - no previously-included directories found matching 'build' 08:56:53 INFO - no previously-included directories found matching 'dist' 08:56:53 INFO - no previously-included directories found matching '.git*' 08:56:53 INFO - Successfully installed jsonschema functools32 08:56:53 INFO - Cleaning up... 08:56:53 INFO - Return code: 0 08:56:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:53 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 0x1080c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97324e3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108027d30>, '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 0x107d8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10801fb20>, '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.Pkea1jMpL1/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.WKOrGuTudK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 08:56:53 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 08:56:53 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 08:56:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pkea1jMpL1/Render', 08:56:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:53 INFO - 'HOME': '/Users/cltbld', 08:56:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:53 INFO - 'LOGNAME': 'cltbld', 08:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:53 INFO - 'MOZ_NO_REMOTE': '1', 08:56:53 INFO - 'NO_EM_RESTART': '1', 08:56:53 INFO - 'PAGER': '/bin/cat', 08:56:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:53 INFO - 'PWD': '/builds/slave/test', 08:56:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:53 INFO - 'SHELL': '/bin/bash', 08:56:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WKOrGuTudK/Listeners', 08:56:53 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 08:56:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:53 INFO - 'USER': 'cltbld', 08:56:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:53 INFO - 'XPC_FLAGS': '0x0', 08:56:53 INFO - 'XPC_SERVICE_NAME': '0', 08:56:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:53 INFO - Downloading/unpacking blobuploader==1.2.4 08:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:56 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 08:56:56 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 08:56:56 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 08:56:56 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 08:56:56 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 08:56:56 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 08:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56: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 08:56:57 INFO - Downloading docopt-0.6.1.tar.gz 08:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:57 INFO - Running setup.py install for blobuploader 08:56:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:57 INFO - Running setup.py install for requests 08:56:58 INFO - Running setup.py install for docopt 08:56:58 INFO - Successfully installed blobuploader requests docopt 08:56:58 INFO - Cleaning up... 08:56:58 INFO - Return code: 0 08:56:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:58 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 0x1080c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97324e3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108027d30>, '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 0x107d8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10801fb20>, '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.Pkea1jMpL1/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.WKOrGuTudK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 08:56:58 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 08:56:58 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 08:56:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pkea1jMpL1/Render', 08:56:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:58 INFO - 'HOME': '/Users/cltbld', 08:56:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:58 INFO - 'LOGNAME': 'cltbld', 08:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:58 INFO - 'MOZ_NO_REMOTE': '1', 08:56:58 INFO - 'NO_EM_RESTART': '1', 08:56:58 INFO - 'PAGER': '/bin/cat', 08:56:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:58 INFO - 'PWD': '/builds/slave/test', 08:56:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:58 INFO - 'SHELL': '/bin/bash', 08:56:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WKOrGuTudK/Listeners', 08:56:58 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 08:56:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:58 INFO - 'USER': 'cltbld', 08:56:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:58 INFO - 'XPC_FLAGS': '0x0', 08:56:58 INFO - 'XPC_SERVICE_NAME': '0', 08:56:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:58 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-s1yJYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:58 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-RtbsO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:58 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-kto6IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-kfDacW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-tnoF9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-6Y3O9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-L_TbDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-5Cngj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-_HQ43z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-UWKasc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-_aIElB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-g27I7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-QqkGS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-lUAEXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-5iDSN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-MB47DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-MByNj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:57:00 INFO - Running setup.py install for manifestparser 08:57:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:57:00 INFO - Running setup.py install for mozcrash 08:57:00 INFO - Running setup.py install for mozdebug 08:57:00 INFO - Running setup.py install for mozdevice 08:57:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Running setup.py install for mozfile 08:57:01 INFO - Running setup.py install for mozhttpd 08:57:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Running setup.py install for mozinfo 08:57:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Running setup.py install for mozInstall 08:57:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Running setup.py install for mozleak 08:57:01 INFO - Running setup.py install for mozlog 08:57:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:57:02 INFO - Running setup.py install for moznetwork 08:57:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:57:02 INFO - Running setup.py install for mozprocess 08:57:02 INFO - Running setup.py install for mozprofile 08:57:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:57:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:57:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:57:02 INFO - Running setup.py install for mozrunner 08:57:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:57:02 INFO - Running setup.py install for mozscreenshot 08:57:02 INFO - Running setup.py install for moztest 08:57:02 INFO - Running setup.py install for mozversion 08:57:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:57:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:57:03 INFO - Cleaning up... 08:57:03 INFO - Return code: 0 08:57:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:03 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 0x1080c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97324e3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108027d30>, '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 0x107d8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10801fb20>, '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.Pkea1jMpL1/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.WKOrGuTudK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 08:57:03 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 08:57:03 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 08:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pkea1jMpL1/Render', 08:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:03 INFO - 'HOME': '/Users/cltbld', 08:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:03 INFO - 'LOGNAME': 'cltbld', 08:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:03 INFO - 'MOZ_NO_REMOTE': '1', 08:57:03 INFO - 'NO_EM_RESTART': '1', 08:57:03 INFO - 'PAGER': '/bin/cat', 08:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:03 INFO - 'PWD': '/builds/slave/test', 08:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:03 INFO - 'SHELL': '/bin/bash', 08:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WKOrGuTudK/Listeners', 08:57:03 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 08:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:03 INFO - 'USER': 'cltbld', 08:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:03 INFO - 'XPC_FLAGS': '0x0', 08:57:03 INFO - 'XPC_SERVICE_NAME': '0', 08:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:03 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-orOori-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:03 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)) 08:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:03 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Fo5vYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:03 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-On2Lg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:03 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)) 08:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:03 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-UvbXUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:03 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-lfZOiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:03 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)) 08:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:03 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-RXaKdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:04 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)) 08:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:04 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-u13aWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:04 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)) 08:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:04 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-D9FqC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:04 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)) 08:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:04 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-wOivRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:04 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)) 08:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:04 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-4L_DlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:04 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-suDopy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:04 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)) 08:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:04 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-hZx9zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:04 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Pr_fUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:04 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)) 08:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:04 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-YVsrgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:04 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-PIL7OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:04 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)) 08:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:04 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-mcGWE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:05 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-coYNdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:05 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)) 08:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:05 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)) 08:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:05 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 08:57:05 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 08:57:05 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 08:57:05 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 08:57:05 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 08:57:05 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 08:57:07 INFO - Downloading blessings-1.6.tar.gz 08:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:57:07 INFO - Installing collected packages: blessings 08:57:07 INFO - Running setup.py install for blessings 08:57:07 INFO - Successfully installed blessings 08:57:07 INFO - Cleaning up... 08:57:07 INFO - Return code: 0 08:57:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:08 INFO - Reading from file tmpfile_stdout 08:57:08 INFO - Current package versions: 08:57:08 INFO - blessings == 1.6 08:57:08 INFO - blobuploader == 1.2.4 08:57:08 INFO - docopt == 0.6.1 08:57:08 INFO - functools32 == 3.2.3-2 08:57:08 INFO - jsonschema == 2.5.1 08:57:08 INFO - manifestparser == 1.1 08:57:08 INFO - mozInstall == 1.12 08:57:08 INFO - mozcrash == 0.17 08:57:08 INFO - mozdebug == 0.1 08:57:08 INFO - mozdevice == 0.48 08:57:08 INFO - mozfile == 1.2 08:57:08 INFO - mozhttpd == 0.7 08:57:08 INFO - mozinfo == 0.9 08:57:08 INFO - mozleak == 0.1 08:57:08 INFO - mozlog == 3.3 08:57:08 INFO - moznetwork == 0.27 08:57:08 INFO - mozprocess == 0.23 08:57:08 INFO - mozprofile == 0.28 08:57:08 INFO - mozrunner == 6.12 08:57:08 INFO - mozscreenshot == 0.1 08:57:08 INFO - mozsystemmonitor == 0.3 08:57:08 INFO - moztest == 0.7 08:57:08 INFO - mozversion == 1.4 08:57:08 INFO - psutil == 3.1.1 08:57:08 INFO - requests == 1.2.3 08:57:08 INFO - wsgiref == 0.1.2 08:57:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:08 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 0x1080c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97324e3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108027d30>, '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 0x107d8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10801fb20>, '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.Pkea1jMpL1/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.WKOrGuTudK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 08:57:08 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 08:57:08 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 08:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pkea1jMpL1/Render', 08:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:08 INFO - 'HOME': '/Users/cltbld', 08:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:08 INFO - 'LOGNAME': 'cltbld', 08:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:08 INFO - 'MOZ_NO_REMOTE': '1', 08:57:08 INFO - 'NO_EM_RESTART': '1', 08:57:08 INFO - 'PAGER': '/bin/cat', 08:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:08 INFO - 'PWD': '/builds/slave/test', 08:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:08 INFO - 'SHELL': '/bin/bash', 08:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WKOrGuTudK/Listeners', 08:57:08 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 08:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:08 INFO - 'USER': 'cltbld', 08:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:08 INFO - 'XPC_FLAGS': '0x0', 08:57:08 INFO - 'XPC_SERVICE_NAME': '0', 08:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:08 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)) 08:57:08 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)) 08:57:08 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)) 08:57:08 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)) 08:57:08 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)) 08:57:08 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)) 08:57:08 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)) 08:57:08 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)) 08:57:08 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)) 08:57:08 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)) 08:57:08 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)) 08:57:08 INFO - Cleaning up... 08:57:08 INFO - Return code: 0 08:57:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:57:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:08 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 0x1080c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97324e3dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108027d30>, '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 0x107d8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10801fb20>, '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.Pkea1jMpL1/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.WKOrGuTudK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 08:57:08 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 08:57:08 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 08:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pkea1jMpL1/Render', 08:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:08 INFO - 'HOME': '/Users/cltbld', 08:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:08 INFO - 'LOGNAME': 'cltbld', 08:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:08 INFO - 'MOZ_NO_REMOTE': '1', 08:57:08 INFO - 'NO_EM_RESTART': '1', 08:57:08 INFO - 'PAGER': '/bin/cat', 08:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:08 INFO - 'PWD': '/builds/slave/test', 08:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:08 INFO - 'SHELL': '/bin/bash', 08:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WKOrGuTudK/Listeners', 08:57:08 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 08:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:08 INFO - 'USER': 'cltbld', 08:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:08 INFO - 'XPC_FLAGS': '0x0', 08:57:08 INFO - 'XPC_SERVICE_NAME': '0', 08:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:57:08 INFO - Cleaning up... 08:57:08 INFO - Return code: 0 08:57:08 INFO - Running post-action listener: _resource_record_post_action 08:57:08 INFO - Running post-action listener: _start_resource_monitoring 08:57:08 INFO - Starting resource monitoring. 08:57:08 INFO - [mozharness: 2016-07-22 15:57:08.760896Z] Finished create-virtualenv step (success) 08:57:08 INFO - [mozharness: 2016-07-22 15:57:08.761865Z] Running install step. 08:57:08 INFO - Running pre-action listener: _resource_record_pre_action 08:57:08 INFO - Running main action method: install 08:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:09 INFO - Reading from file tmpfile_stdout 08:57:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:57:09 INFO - Reading from file tmpfile_stdout 08:57:09 INFO - Output received: 08:57:09 INFO - Usage: mozinstall [options] installer 08:57:09 INFO - Options: 08:57:09 INFO - -h, --help show this help message and exit 08:57:09 INFO - -d DEST, --destination=DEST 08:57:09 INFO - Directory to install application into. [default: 08:57:09 INFO - "/builds/slave/test"] 08:57:09 INFO - --app=APP Application being installed. [default: firefox] 08:57:09 INFO - mkdir: /builds/slave/test/build/application 08:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:57:45 INFO - Reading from file tmpfile_stdout 08:57:45 INFO - Output received: 08:57:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:57:45 INFO - Running post-action listener: _resource_record_post_action 08:57:45 INFO - [mozharness: 2016-07-22 15:57:45.551095Z] Finished install step (success) 08:57:45 INFO - [mozharness: 2016-07-22 15:57:45.551249Z] Running run-tests step. 08:57:45 INFO - Running pre-action listener: _resource_record_pre_action 08:57:45 INFO - Running main action method: run_tests 08:57:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:57:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:57:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:57:45 INFO - 2016-07-22 08:57:45.565 screenresolution[1983:10570] starting screenresolution argv=screenresolution get 08:57:45 INFO - 2016-07-22 08:57:45.567 screenresolution[1983:10570] Display 0: 1600x1200x32@60 08:57:45 INFO - 2016-07-22 08:57:45.572 screenresolution[1984:10572] starting screenresolution argv=screenresolution list 08:57:45 INFO - Available Modes on Display 0 08:57:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:57:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:57:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:57:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:57:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:57:45 INFO - Intel Iris: 08:57:45 INFO - Chipset Model: Intel Iris 08:57:45 INFO - Type: GPU 08:57:45 INFO - Bus: Built-In 08:57:45 INFO - VRAM (Dynamic, Max): 1536 MB 08:57:45 INFO - Vendor: Intel (0x8086) 08:57:45 INFO - Device ID: 0x0a2e 08:57:45 INFO - Revision ID: 0x0009 08:57:45 INFO - Displays: 08:57:45 INFO - Display: 08:57:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:57:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:57:45 INFO - Display Serial Number: 1600x1200 60 08:57:45 INFO - Main Display: Yes 08:57:45 INFO - Mirror: Off 08:57:45 INFO - Online: Yes 08:57:45 INFO - Rotation: Supported 08:57:45 INFO - Return code: 0 08:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:57:45 INFO - Python 2.7.3 08:57:45 INFO - Return code: 0 08:57:45 INFO - grabbing minidump binary from tooltool 08:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:57:45 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 0x108027d30>, '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 0x107d8cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10801fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:57:45 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 08:57:45 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 08:57:45 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 08:57:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:57:45 INFO - Return code: 0 08:57:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:57:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:57:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:57:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:57:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0105 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:57:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Pkea1jMpL1/Render', 08:57:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:45 INFO - 'HOME': '/Users/cltbld', 08:57:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:45 INFO - 'LOGNAME': 'cltbld', 08:57:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:57:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:45 INFO - 'MOZ_NO_REMOTE': '1', 08:57:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:57:45 INFO - 'NO_EM_RESTART': '1', 08:57:45 INFO - 'PAGER': '/bin/cat', 08:57:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:45 INFO - 'PWD': '/builds/slave/test', 08:57:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:57:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:45 INFO - 'SHELL': '/bin/bash', 08:57:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WKOrGuTudK/Listeners', 08:57:45 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 08:57:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:45 INFO - 'USER': 'cltbld', 08:57:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:45 INFO - 'XPC_FLAGS': '0x0', 08:57:45 INFO - 'XPC_SERVICE_NAME': '0', 08:57:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:57:46 INFO - mozversion application_buildid: 20160722080026 08:57:46 INFO - mozversion application_changeset: ff29f08b72c466b65dea5efa6f82f99add8f17ef 08:57:46 INFO - mozversion application_display_name: Nightly 08:57:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:57:46 INFO - mozversion application_name: Firefox 08:57:46 INFO - mozversion application_remotingname: firefox 08:57:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:57:46 INFO - mozversion application_vendor: Mozilla 08:57:46 INFO - mozversion application_version: 50.0a1 08:57:46 INFO - mozversion platform_buildid: 20160722080026 08:57:46 INFO - mozversion platform_changeset: ff29f08b72c466b65dea5efa6f82f99add8f17ef 08:57:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:57:46 INFO - mozversion platform_version: 50.0a1 08:57:46 INFO - using testdate: 1469203066 08:57:46 INFO - actual date: 1469203066 08:57:46 INFO - starting webserver on 'localhost:49403' 08:57:46 INFO - SUITE-START | Running 2 tests 08:57:46 INFO - TEST-START | dromaeo_css 08:57:46 INFO - operating with platform_type : mac_ 08:57:46 INFO - Initialising browser for dromaeo_css test... 08:57:46 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmp5knZYy/profile http://localhost:49403/getInfo.html) 08:57:48 INFO - PROCESS | 1994 | JavaScript error: , line 0: uncaught exception: undefined 08:57:49 INFO - PROCESS | 1994 | __metrics Screen width/height:1600/1200 08:57:49 INFO - PROCESS | 1994 | colorDepth:24 08:57:49 INFO - PROCESS | 1994 | Browser inner width/height: 1024/689 08:57:49 INFO - PROCESS | 1994 | __metrics 08:57:49 ERROR - PROCESS | 1994 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:57:50 INFO - TEST-INFO | 1994: exit 0 08:57:50 INFO - Browser initialized. 08:57:50 INFO - Running cycle 1/1 for dromaeo_css test... 08:57:50 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmp5knZYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:02 INFO - PROCESS | 1997 | RSS: Main: 256417792 08:58:02 INFO - PROCESS | 1997 | 08:58:51 INFO - PROCESS | 1997 | 1469203131658 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:01:03 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49403/tests/dromaeo/cssquery-ext.html) 09:01:04 INFO - PROCESS | 1997 | RSS: Main: 271396864 09:01:04 INFO - PROCESS | 1997 | 09:04:07 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49403/tests/dromaeo/cssquery-ext.html (next: http://localhost:49403/tests/dromaeo/cssquery-jquery.html) 09:04:07 INFO - PROCESS | 1997 | RSS: Main: 281600000 09:04:07 INFO - PROCESS | 1997 | 09:07:09 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49403/tests/dromaeo/cssquery-mootools.html) 09:07:10 INFO - PROCESS | 1997 | RSS: Main: 288866304 09:07:10 INFO - PROCESS | 1997 | 09:10:12 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49403/tests/dromaeo/cssquery-prototype.html) 09:10:12 INFO - PROCESS | 1997 | RSS: Main: 288743424 09:10:12 INFO - PROCESS | 1997 | 09:13:15 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49403/tests/dromaeo/cssquery-yui.html) 09:13:15 INFO - PROCESS | 1997 | RSS: Main: 293486592 09:13:15 INFO - PROCESS | 1997 | 09:16:18 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49403/tests/dromaeo/cssquery-yui.html (next: http://localhost:49403/tests/dromaeo/cssquery-dojo.html) 09:16:18 INFO - PROCESS | 1997 | RSS: Main: 293507072 09:16:18 INFO - PROCESS | 1997 | 09:16:18 INFO - PROCESS | 1997 | __start_tp_report 09:16:18 INFO - PROCESS | 1997 | _x_x_mozilla_page_load 09:16:18 INFO - PROCESS | 1997 | _x_x_mozilla_page_load_details 09:16:18 INFO - PROCESS | 1997 | |i|pagename|runs| 09:16:18 INFO - PROCESS | 1997 | |0;dojo.html;2838.517452033155;3395.660433956604;3406.437937740273;3440.7591468597193;3443.845026973786;5763.74063167158;5857.7364018619155;5917.674527900964;5938.46553810157;5962.970185149074;5717.742701578429;5870.236869206997;5900.380460051686;5913.379095195007;5977.701114944246;5230.816921407742;5291.86770330741;5367.651102678314;5379.81170659027;5411.540019098381;5327.573794096483;5442.91835622466;5459.781608735646;5477.20580515825;5547.084731019397;5229.895402091975;5318.149096144598;5345.118055520835;5353.785848566053;5406.648567843077;5353.732313384316;5382.165764306539;5383.542398896098;5394.703291318976;5403.405625381205;5297.973510132463;5317.069512835238;5346.134310669381;5394.568434525228;5422.267993820823;4471.575200355961;5760.596758226926;5927.288725352985;5939.109133629947;6059.48494377974;6214.223222097238;6228.813135605939;6259.843503912393;6267.811965641038;6272.1219029335925;6321.051842223657;6325.462335701471;6330.683465826736;6348.555601107924;6359.682015899187;5913.645181289136;5982.97008514959;6044.214252147192;6060.969695151584;6143.907841382383;6353.078803573456;6393.264774550986;6407.13503677007;6407.231132264065;6409.9679501602195;6174;6179.876402471926;6202.5658203925295;6229.1590635264565;6244.188255526752;6172.567920245539;6222.408871157233;6227.221597300338;6304.779332723424;6352.428281454691;6164.599301045508;6169.321374648785;6222.937770622327;6240.375962403723;6250.874982500415;6226.782062627877;6229.750809967551;6230.6573138476915;6239.688015599293;6254.312025677172;4950.628702847301;5032.773525191302;5042.344495215599;5057.9378330551;5127.384713834289;4567.177907976529;4590.334401511762;4599.471060827981;4602.815887364468;4640.025594625099;5977.043673012297;6089.725962331617;6089.8477538061015;6092.086187071975;6092.878142437126;5321.680699158062;5802.723400851806;6234.096056071844;6237.812865614039;6313.053042043638;4734.55021772931;5294.152935530296;6070.119832624245;6074.878502429927;6089.056196289582;5574.749136288877;5576.637518561281;5588.3573389060775;5598.552115830724;5604.4395560444445;6260.311365749764;6408.711607977559;6446.0975463434215;6522.967385163044;6523.543351965412;5800.187973683604;5857.447776339188;6349.6507692077375;6358.395952384516;6387.041943708481;5412.052890744183;5955.374685657944;6335.922893108275;6490.286068532363;6518.869622607616;6050.7277172526465;6111.257501106225;6150.200473938359;6169.475594574512;6296.33888441707;6295.842603934938;6323.304436512072;6325.746970121144;6327.96836015817;6337.6197428154455;5135.974320128375;6193.071039344134;6200.968995154995;6212.565120441525;6241.469475094668;4709.929351059805;6102.474381404649;6121.75750147007;6179.528188724546;6254.405831446005;6004.399560044136;6014.969925150346;6084.513238940785;6097.240212207355;6125.388069147199;6202.255729312511;6226.3151053385;6231.345708700703;6240.781572644935;6248.343923887926;6089.238845144357;6109.725062372293;6150.10823430609;6153.72308246139;6154.538409619386 09:16:18 INFO - PROCESS | 1997 | |1;ext.html;468.6531966344904;484.49854400695267;494.09580467744007;537.6102325813786;565.7312776431198;39508.60491395089;41812.790936045356;42270;42274;42365.36451953215;42465;42748.717538473895;42833.7858310708;42959.78520107395;42987.140257194835;7786.922130778705;8972.801663592429;9648.903510964907;9670.709878703632;9681.854772178423;9498.715038548855;9537.33238673293;9599.376040557341;9662;9691.612335506572;8232.1356257593;9588.424694518317;9699.127078562928;9758.951205243964;9761.560729767178;9689.127978481934;9717.708468745948;9738.269629777795;9745.707628771148;9750.853737193947;9717.31978761487;9783.804323913553;9803.607855685836;9829.311948163631;9833.508324583741;40403.59596404028;40463.1907361854;40802.18395632071;40867;41056.79471602623;3433.6909678128836;3524.823758812049;3531.3820081485637;3679.411294192943;4405.691601587891;32098.518522222184;33278.334433311444;33287.83356083228;33468.99593012214;33497.33005339879;3317.717993970515;3383.9661603383897;3408.471686888536;3426.554547908756;3430.1596108953217;475156;510341;538125.3093734545;538282;539556;64462.67768661126;64779;65191.674041629485;65279.673601631686;65377;65883;68062.65968670126;68518;68581;68651.31348686549;16916.407925722542;16999.74500382495;17296.481105566854;17297.962122272704;17309.874858134182;13058.477660893648;13117.868821311855;13153.73692526144;13158.934205328913;13178.736425271632;17329.913350433166;18160;18205.089745512938;18253.45239642813;18262.36081737133;7056.294370562902;7156.177039640508;7223.747168849065;7294.452916031319;7314.963425182947;848.5545088828414;919.9264058875274;998.5306905754284;1031.4997226345217;1078.164422572497;26877.328066798487;27120;28150.577741333895;31535.684643153276;31604.367912641617;956.268454632207;1075.1398880895254;1101.7245688577855;1104.2932523185168;1105.2484310668822;15782.68434631301;16157.4344897928;16324.93887897283;16536.6692666146;16711.498655040366;597632.0236797663;713001;717454;717970;722940;61276;63016.68491657513;63283.68358158272;63480.047799282125;63540.682296588224;1398.2309729648653;1403.7262733767022;1451.477468111479;1452.6658868460102;1453.396840311259;26903.865480673256;31072.53391199179;31380;31760.68239317577;32240.67759322377;42107;45122;54268.914621708136;55094.72452637711;55304.89390212254;602663;611408;611625;612520;613074;27175.86412067927;27850;27946.580801288404;28075.157745267676;28302.716972830007;48933.26600101073;49371;50124.74937625288;50697.49302506928;51028.74485627548;36023.63976360203;39392.81821545358;42799.5720042808;43152.56847431485;43799.56200437955;41230.79384603058;41344.79327603343;41431.1713765717;42323.57676423196;42646;40388;40624.1875162501;40858.591414086666;41012;42575;32189.517157243128;36302.636973629924;36443.60166988482;36926.815365923;36953.26093478169;22076.88961555182;26618.7338126624;26815.597766033134;27057.59413608837;27372.86313568499 09:16:18 INFO - PROCESS | 1997 | |2;jquery.html;368.8266514738073;369.9667029967304;385.7820331512696;392.58582195783436;403.2660557784833;16972.915135424322;19178.90410547947;20622.793772062294;20661.483462913435;21050;20228.69656955143;20442.08010639521;20811.479713007182;20993.265235716754;21056.368308950718;4492.910141797162;5023.522765337306;5824.504917082042;5931.317898441691;6014.3985601439945;5993.0710739835395;6042.758289668408;6058.757649694007;6060.2424696912885;6062.696865156725;5720.456556627114;5847.122931560258;5856.648601083949;5900.940990590082;5936.786804033099;5763.567732420043;5777.959967205901;5866.911996320037;5867.061270196769;5882.441168089046;4970.552650261494;4990.675606085629;5047.899042019176;5150.690958542499;5157.149070403379;24999.250022499353;25354.619680704804;25393.873030634728;25599.872000640065;25872.611910821164;2173.6956826044366;2265.988670056656;2475.0965897447304;2607.765301122908;2968.1392396205074;15024.023438476464;15654.686906261924;15766.76349854753;15875.52373428799;15985.92007039969;1845.7877344105466;1871.4946964319693;1917.5781328107794;1931.7102434634776;1932.7680678318552;109999;113280.4335978323;113490;113913.43043284814;114908.42545787217;10381.84427233592;10440;10535.84196237057;10821.9458902705;11053.723656908482;13035.739285214433;13402.59792206216;13404.798928016087;13408.798868016987;13413.262270575016;8387.62255698495;8592.8711069334;8626.223639872442;8797.51613661242;8798.208161265517;7567.848643027109;8494.06565277819;8775.42959707617;8794;8899.688510902217;6339.239291284983;6491.740330386826;6523.412892839572;6524.641144737085;6548.967255163789;1731.9913400432918;1767.301915743274;1833.5966087460738;1856.5729882127187;1901.0684764465313;909.7270818754347;911.3893691226893;940.2478017585904;965.3146266151111;1019.1642852860731;22141.446463838212;22195.33413997583;22408.66387004196;22440.438989025406;22600.66099008516;967.5355829201882;980.6518685866557;983.4296108257194;984.247051005981;1024.062982371137;11461.885381146249;12369.814452783216;12414.565490207799;12440.875591244152;12571.937140314423;567973;572434;575265;578959;584285;78476;92977;116941;120794.96025198705;133929;843.9535825529532;982.8427451607708;999.165696643311;1033.204432586904;1035.7203555040096;14143.787843182155;15335.156566388956;18330.450086497425;18519.629607408046;18840.811591883907;43713.907152321444;47586.524134759595;50972.72568185677;53313.46686533085;53840.461595383546;75430.62284688541;75722;76524;76810;77103.61448192723;7611.124720656974;7727.42044346665;7818.140004599603;7845.058592968652;7918.485298455812;9971.252156088178;12083.69790755203;12179.147459678092;12186.878131218575;12281.815772763237;10453.059224669816;10623.89376106229;11030.117590592572;11036.11711063129;11165.660120785233;10102;11003.944980275048;11022.50398732075;11109.777804443704;11244.887551124384;11084.61203857861;11201.15991300672;11366.204365694322;11393.373364464702;11473.541058357907;7109.933509973545;7537.472376933562;7988.320992715684;8068.798280043045;8249.711260106107;10325.32885362449;10627.787444250916;11053.557857685924;11106.888931110585;11199.160062995144 09:16:18 INFO - PROCESS | 1997 | |3;mootools.html;1527.5570084675444;1564.8278689344172;1734.2629382512437;1794.9730754038692;1910.3600293901543;7983.682692355769;8517.361197910159;8590.87113693295;8963.103689631042;9001.864972025416;7159.212486626467;7796.454248202628;8087.19128087191;8159.959200204005;8776.297896168307;2377.2274010946426;2410.457647029422;2414.7223069347074;2414.915477958272;2419.9274021779374;2283.6346184610466;2358.3396648938324;2360.6104992676187;2362.65741467488;2383.52329534093;2348.5655153796515;2360.527894421114;2382.9642555361684;2397.1729753235195;2406.133791834938;2084.551821358408;2279.4301424643922;2294.4378627236265;2359.976400235993;2396.7962723168553;2338.672585837984;2371.833971621987;2381.2499062795164;2386.7851893329685;2389.330987323535;8881.378303518757;8906.332025098143;8919.375643704943;8979.281657467387;8991.55042247885;5297.629165958385;5425.647332923348;5459.972700136514;5462.071447853875;5470.9452905470835;3561.0919215599856;3667.1015601177614;3683.594804571495;3704.8888533344043;3735.962640373589;1088.5917780832187;1089.9128069754402;1097.1716354152643;1100.031971864762;1104.6354702948088;11594.304341739522;11650.708732281591;11657.825132623017;11696.719139767749;11726.824097638542;4440.555944405598;4551.8634440966825;4660.021395506914;4683.039976804746;4697.107549565571;9206.401583897024;9214;9263.212626926652;9264.95367523158;9267.351285410092;5224.346956630421;5317;5317.73411329432;5326.840194794162;5342.2787923630585;4502.707324023928;4844.249141383091;4963.851084467472;4982.651214415028;4999.375078115236;3838.481804956295;3850.7882066486613;3956.823746939172;3957.742746721454;4001;1179.4515550269166;1191.6127258640977;1194.092489707811;1194.396829601046;1202.5971299614553;814.9144339844231;844.6199210355364;905.977350566228;952.6522819170953;1004.492731170754;5011.774470148852;5939.138824870456;6104.755809767559;6232.220972378453;6330.430261276507;419.5929947950483;445.9876081295506;448.23352067964146;448.93714879916837;459.68970944612255;4095.2219078375015;4149.170165966819;4162.2299874522705;4259.382389553497;4286.421333119989;10707.411092389837;10709.143268538499;10732.678019659423;10888.455577221266;10916;9953.751156221153;10635.308704934154;10710.732231694114;10836.458177091272;10940.945295273472;8065.677372905018;8356.665733370597;8356.70471076984;8365.745138229315;8370.581470926429;5840.429516793607;5863.589548731547;6057.757689692363;6267.655278959701;6329.90505142414;9214.907850921405;9988.250881184085;10180.185585153318;10228.744281393025;10268.845967310646;9558.235341172829;9607.183389411979;9689.70930872075;9753.366031207948;9765.462899540593;7036.437085033082;7530.322270995636;7696.884546731915;8010.519368837889;8174.019117705676;8291.58542072906;8342.624581893708;8363.163683631588;8495.74512764618;8498.405111642373;7458.440616953859;7659.272369124924;7693.923060769321;7732.110807257238;7769.028871391076;6286.339934307015;6368.949123394588;7034.050403195503;7053.717851285891;7481.476296659399;7079.929200708133;7135.393491553276;7175.784726458214;7203.675834587351;7226.4218862491925;4588.793504292248;4620.821690468909;4855;5188.844334669966;5281.049411106038;4719.622430205644;5119.334486516729;5218.217267409919;5271.420143784104;5281.60387970896 09:16:18 INFO - PROCESS | 1997 | |4;prototype.html;298.5775128193606;303.08015173947075;304.9161480592837;315.4212020941572;317.5173735921398;5312.78748850046;5475.342958844944;5572.300448363248;5703.657780533171;5752.942470575298;4835.75821208939;5459.972700136504;5560;5606.383297837235;5654.0493529732275;4246.810892949979;4298.828046878121;4315.266404711198;4315.561707635176;4316.589923957219;3479.6868281854627;3824.2351529694033;4172.18642364739;4280.914381712364;4331.610155086041;4046.453728746611;4163.229802486535;4237.936430953539;4243.427137336451;4262;3484.5992710838323;3868.4777555030273;4257.425247591582;4291.141771645684;4300.838773531161;3113.595232619745;3706.8887933362043;3716.4611131385795;3735.290294843971;3736.981315093407;3987.6840642587877;4651.930221046687;5269.762860671279;5372.946270537283;5476.342838859362;4081.3877918312196;4303.8063287151845;4665.673402861801;4899.093667671492;4957.256411538262;4856.490068542823;5105.514976077304;5758.049921762904;5965.850853728648;6051.515878729735;3328.3176948725695;3416.4704470806814;3742;3767.5102236709326;4075.246079475277;6169.506439484875;6271.749130034793;6299.181106456177;6304;6307.391615138111;3516.7339757687214;4073.0021144819116;4157.937630935538;4165.250254954138;4168.499780026416;3639.7816131032223;3643.927121457556;3859.9192226176156;4072.615310794344;4208.242516347026;4313.16690406576;4721.716696998191;4961.8511444656715;4964;4979.57673597741;5057.291979122926;5727.31272247333;5996.8800623988145;6001.3098493672915;6042.939570604326;1311.6851955530603;1416.9160592147016;1436.4397884824928;1450.166154461168;1461.751502244621;724.0876495615457;725.365305357812;773.4547144263281;863.4387648028707;899.8976254088689;3951.723379363417;4614.100250451197;4638.79657162845;4672.76636168197;4717.764111794397;4463.486699029589;4761.642876784255;5150.399048480494;5219.42586315505;5240.895182096337;4219.1139860629;4655.185342565038;4668;4670.342028579873;4718.386609740781;2308.9422764431024;2494.9625755613315;2547.8216524843456;2736.1107640017076;2736.6305548750665;4423.646108311327;4771.4512831024185;4861.805527778849;5346.839594812084;5381.461853814587;4074.735142215806;4750.311204875274;5346.679199248058;5375.650582712111;5382.192671099367;4668.85993420198;4744.272043574889;5073.847784566469;5322.574194064466;5324;4521.321801729767;4749.3113498541825;5184.637075404686;5213.435969209298;5232.319798426181;4548.863534093983;5066.797328106982;5157.226416037624;5171;5551.500364967173;5112.3865136183895;5639.885043108834;6002.429769171922;6412.274783217207;6469.7412103515335;3664.725145614036;3754.831032603485;3828.4640150378414;4094.488188976378;4106.7946602670345;4999.575036121971;6047.758089676364;6126;6235.781747638811;6260.655663938527;6012.218411606463;6037.215162028908;6063.423974722395;6080.635161890301;6115.357887421935;5320.893582128413;5689.914651280152;6064.636121832704;6065.727042283196;6122.020476723703;4883.658143929891;4912.336834527436;5378.677279363251;5885;5959.970200148971;6030.3668114847305;6031.457168854648;6063.909041364472;6073.787417440369;6099.9390006099375;4946.975265123651;5688.7440065198;5845.298564172156;5888.4700376966275;5969.85085369258 09:16:18 INFO - PROCESS | 1997 | |5;yui.html;746.1009483572296;774.8024253815277;788.9940326084242;807.2532907060969;818.9262966333029;15281.617959551017;15812.367505299775;15963.920180399082;16027.198640067994;16095.195240237985;14074.577762667112;14471.276436178176;14587.197704126269;14606.19665918374;14630.268486575682;699.2029086841005;849.4054162086534;871.3508436215029;876.3339861705102;876.3996662286354;877.0308808766317;890.9554522273893;891.4205766251923;892.7768057985504;893.3478560650728;712.7612249896291;939.9389039712431;941.3081385181886;942.0579420579421;942.185009966381;904.2856143646577;922.6862866625313;924.3160061554469;938.2212763406391;938.5448057692014;670.3464122480591;670.8658268346351;678.6844117485343;692.4322055914153;692.5394612582627;14668;14716.926415367961;14978.850211497964;15149.394024239018;15223.086614803036;14869.098455521429;14925;14963.177025263607;14976.326065327086;15324.923375383052;11822.172447928648;12158.5744498943;12423.503059877594;12433.875661243454;12482;3880.631340022693;3915.295246855565;4103.733257338294;4128.876133715993;4132.648724858361;112292;113533;113878;114898.42550787193;117471.4126429371;11523.423828808694;11648.475818588184;11672.649820505398;11700;11990.580329688593;19698.70451943222;20091.497712557302;21333.78666213349;24370.025198991843;24570.87714561416;6971;8244.381671374671;8311.6675332986;8393.412461127662;8420.242178203991;4434.224010798098;4511.8646440606835;4514.367988481616;4572.7713614319155;4742.928856067162;3585.4442561403025;3695.4456831474954;3696.1129328960856;3930.7051971102283;4110.17796440713;728.1589763822793;737.9151397589238;747.9626018699153;747.9738209162654;752.5484709174451;522.3575002746567;576.3803910795912;688.132952479869;698.9685464154023;706.8868980963022;9434.528273586293;9566.186874115778;9846.359986600992;9962.203023758082;10250.487475626189;579.982600521985;677.4106527321163;691.2051141187574;708.7377670261933;712.7505373119367;4351.607485604576;4648.1191377976875;4993.650444468925;5020.949790502048;5026.84919452417;81178;95330.0466995335;111609;147306;155474;98145.50927245319;107343.4632826831;111990;112744;113489;99808.50670226508;100132.49933750284;100678.99321006697;100838;102786.9999999985;9620.84549854022;9989.051040151175;10167.644132455329;10195.980401959745;10249.538770755484;55794;55941;58559.414405855394;59830.70084649549;59883;67624;68617.2845678842;77713.83429248452;84962.30075398581;95132;10938.289011214245;13783.862161378658;13919.025668203129;13989.650258743206;14148.736202207598;15141.697166056398;15174.468893588672;15213.239338032832;15767.68464630724;15972.12153331578;11431.485583148611;13982;14209.005369624027;14376.751468491286;14818.555443336718;13763.655908602364;14027;14187.432502699776;14288.642783930485;14482.34829432657;13795.586132416043;14077.225752583297;14272.500462483764;14428.134311941318;14463;10994.982448485898;11050.502727377127;11515.366654834064;11610.303381797119;11771.941140294244;11251.537300151256;11530.94234528822;11555.4800033997;11703.180777345504;11780.293182409083 09:16:18 INFO - PROCESS | 1997 | __end_tp_report 09:16:18 INFO - PROCESS | 1997 | __start_cc_report 09:16:18 INFO - PROCESS | 1997 | _x_x_mozilla_cycle_collect,447 09:16:18 INFO - PROCESS | 1997 | __end_cc_report 09:16:18 INFO - PROCESS | 1997 | __startTimestamp1469204178915__endTimestamp 09:16:18 INFO - PROCESS | 1997 | 09:16:18 INFO - PROCESS | 1997 | ------- Summary: start ------- 09:16:18 INFO - PROCESS | 1997 | Number of tests: 6 09:16:18 INFO - PROCESS | 1997 | 09:16:18 INFO - PROCESS | 1997 | [#0] dojo.html Cycles:165 Average:5815.39 Median:6089.24 stddev:656.30 (10.8%) stddev-sans-first:615.37 09:16:18 INFO - PROCESS | 1997 | Values: 2838.5 3395.7 3406.4 3440.8 3443.8 5763.7 5857.7 5917.7 5938.5 5963.0 5717.7 5870.2 5900.4 5913.4 5977.7 5230.8 5291.9 5367.7 5379.8 5411.5 5327.6 5442.9 5459.8 5477.2 5547.1 5229.9 5318.1 5345.1 5353.8 5406.6 5353.7 5382.2 5383.5 5394.7 5403.4 5298.0 5317.1 5346.1 5394.6 5422.3 4471.6 5760.6 5927.3 5939.1 6059.5 6214.2 6228.8 6259.8 6267.8 6272.1 6321.1 6325.5 6330.7 6348.6 6359.7 5913.6 5983.0 6044.2 6061.0 6143.9 6353.1 6393.3 6407.1 6407.2 6410.0 6174.0 6179.9 6202.6 6229.2 6244.2 6172.6 6222.4 6227.2 6304.8 6352.4 6164.6 6169.3 6222.9 6240.4 6250.9 6226.8 6229.8 6230.7 6239.7 6254.3 4950.6 5032.8 5042.3 5057.9 5127.4 4567.2 4590.3 4599.5 4602.8 4640.0 5977.0 6089.7 6089.8 6092.1 6092.9 5321.7 5802.7 6234.1 6237.8 6313.1 4734.6 5294.2 6070.1 6074.9 6089.1 5574.7 5576.6 5588.4 5598.6 5604.4 6260.3 6408.7 6446.1 6523.0 6523.5 5800.2 5857.4 6349.7 6358.4 6387.0 5412.1 5955.4 6335.9 6490.3 6518.9 6050.7 6111.3 6150.2 6169.5 6296.3 6295.8 6323.3 6325.7 6328.0 6337.6 5136.0 6193.1 6201.0 6212.6 6241.5 4709.9 6102.5 6121.8 6179.5 6254.4 6004.4 6015.0 6084.5 6097.2 6125.4 6202.3 6226.3 6231.3 6240.8 6248.3 6089.2 6109.7 6150.1 6153.7 6154.5 09:16:18 INFO - PROCESS | 1997 | 09:16:18 INFO - PROCESS | 1997 | [#1] ext.html Cycles:180 Average:74522.87 Median:42415.18 stddev:164007.76 (386.7%) stddev-sans-first:164373.60 09:16:18 INFO - PROCESS | 1997 | Values: 468.7 484.5 494.1 537.6 565.7 39508.6 41812.8 42270.0 42274.0 42365.4 42465.0 42748.7 42833.8 42959.8 42987.1 7786.9 8972.8 9648.9 9670.7 9681.9 9498.7 9537.3 9599.4 9662.0 9691.6 8232.1 9588.4 9699.1 9759.0 9761.6 9689.1 9717.7 9738.3 9745.7 9750.9 9717.3 9783.8 9803.6 9829.3 9833.5 40403.6 40463.2 40802.2 40867.0 41056.8 3433.7 3524.8 3531.4 3679.4 4405.7 32098.5 33278.3 33287.8 33469.0 33497.3 3317.7 3384.0 3408.5 3426.6 3430.2 475156.0 510341.0 538125.3 538282.0 539556.0 64462.7 64779.0 65191.7 65279.7 65377.0 65883.0 68062.7 68518.0 68581.0 68651.3 16916.4 16999.7 17296.5 17298.0 17309.9 13058.5 13117.9 13153.7 13158.9 13178.7 17329.9 18160.0 18205.1 18253.5 18262.4 7056.3 7156.2 7223.7 7294.5 7315.0 848.6 919.9 998.5 1031.5 1078.2 26877.3 27120.0 28150.6 31535.7 31604.4 956.3 1075.1 1101.7 1104.3 1105.2 15782.7 16157.4 16324.9 16536.7 16711.5 597632.0 713001.0 717454.0 717970.0 722940.0 61276.0 63016.7 63283.7 63480.0 63540.7 1398.2 1403.7 1451.5 1452.7 1453.4 26903.9 31072.5 31380.0 31760.7 32240.7 42107.0 45122.0 54268.9 55094.7 55304.9 602663.0 611408.0 611625.0 612520.0 613074.0 27175.9 27850.0 27946.6 28075.2 28302.7 48933.3 49371.0 50124.7 50697.5 51028.7 36023.6 39392.8 42799.6 43152.6 43799.6 41230.8 41344.8 41431.2 42323.6 42646.0 40388.0 40624.2 40858.6 41012.0 42575.0 32189.5 36302.6 36443.6 36926.8 36953.3 22076.9 26618.7 26815.6 27057.6 27372.9 09:16:18 INFO - PROCESS | 1997 | 09:16:18 INFO - PROCESS | 1997 | [#2] jquery.html Cycles:180 Average:33708.26 Median:25374.25 stddev:95723.69 (377.2%) stddev-sans-first:95959.49 09:16:18 INFO - PROCESS | 1997 | Values: 368.8 370.0 385.8 392.6 403.3 16972.9 19178.9 20622.8 20661.5 21050.0 20228.7 20442.1 20811.5 20993.3 21056.4 4492.9 5023.5 5824.5 5931.3 6014.4 5993.1 6042.8 6058.8 6060.2 6062.7 5720.5 5847.1 5856.6 5900.9 5936.8 5763.6 5778.0 5866.9 5867.1 5882.4 4970.6 4990.7 5047.9 5150.7 5157.1 24999.3 25354.6 25393.9 25599.9 25872.6 2173.7 2266.0 2475.1 2607.8 2968.1 15024.0 15654.7 15766.8 15875.5 15985.9 1845.8 1871.5 1917.6 1931.7 1932.8 109999.0 113280.4 113490.0 113913.4 114908.4 10381.8 10440.0 10535.8 10821.9 11053.7 13035.7 13402.6 13404.8 13408.8 13413.3 8387.6 8592.9 8626.2 8797.5 8798.2 7567.8 8494.1 8775.4 8794.0 8899.7 6339.2 6491.7 6523.4 6524.6 6549.0 1732.0 1767.3 1833.6 1856.6 1901.1 909.7 911.4 940.2 965.3 1019.2 22141.4 22195.3 22408.7 22440.4 22600.7 967.5 980.7 983.4 984.2 1024.1 11461.9 12369.8 12414.6 12440.9 12571.9 567973.0 572434.0 575265.0 578959.0 584285.0 78476.0 92977.0 116941.0 120795.0 133929.0 844.0 982.8 999.2 1033.2 1035.7 14143.8 15335.2 18330.5 18519.6 18840.8 43713.9 47586.5 50972.7 53313.5 53840.5 75430.6 75722.0 76524.0 76810.0 77103.6 7611.1 7727.4 7818.1 7845.1 7918.5 9971.3 12083.7 12179.1 12186.9 12281.8 10453.1 10623.9 11030.1 11036.1 11165.7 10102.0 11003.9 11022.5 11109.8 11244.9 11084.6 11201.2 11366.2 11393.4 11473.5 7109.9 7537.5 7988.3 8068.8 8249.7 10325.3 10627.8 11053.6 11106.9 11199.2 09:16:18 INFO - PROCESS | 1997 | 09:16:18 INFO - PROCESS | 1997 | [#3] mootools.html Cycles:180 Average:5686.34 Median:4991.01 stddev:3171.95 (63.6%) stddev-sans-first:3165.45 09:16:18 INFO - PROCESS | 1997 | Values: 1527.6 1564.8 1734.3 1795.0 1910.4 7983.7 8517.4 8590.9 8963.1 9001.9 7159.2 7796.5 8087.2 8160.0 8776.3 2377.2 2410.5 2414.7 2414.9 2419.9 2283.6 2358.3 2360.6 2362.7 2383.5 2348.6 2360.5 2383.0 2397.2 2406.1 2084.6 2279.4 2294.4 2360.0 2396.8 2338.7 2371.8 2381.2 2386.8 2389.3 8881.4 8906.3 8919.4 8979.3 8991.6 5297.6 5425.6 5460.0 5462.1 5470.9 3561.1 3667.1 3683.6 3704.9 3736.0 1088.6 1089.9 1097.2 1100.0 1104.6 11594.3 11650.7 11657.8 11696.7 11726.8 4440.6 4551.9 4660.0 4683.0 4697.1 9206.4 9214.0 9263.2 9265.0 9267.4 5224.3 5317.0 5317.7 5326.8 5342.3 4502.7 4844.2 4963.9 4982.7 4999.4 3838.5 3850.8 3956.8 3957.7 4001.0 1179.5 1191.6 1194.1 1194.4 1202.6 814.9 844.6 906.0 952.7 1004.5 5011.8 5939.1 6104.8 6232.2 6330.4 419.6 446.0 448.2 448.9 459.7 4095.2 4149.2 4162.2 4259.4 4286.4 10707.4 10709.1 10732.7 10888.5 10916.0 9953.8 10635.3 10710.7 10836.5 10940.9 8065.7 8356.7 8356.7 8365.7 8370.6 5840.4 5863.6 6057.8 6267.7 6329.9 9214.9 9988.3 10180.2 10228.7 10268.8 9558.2 9607.2 9689.7 9753.4 9765.5 7036.4 7530.3 7696.9 8010.5 8174.0 8291.6 8342.6 8363.2 8495.7 8498.4 7458.4 7659.3 7693.9 7732.1 7769.0 6286.3 6368.9 7034.1 7053.7 7481.5 7079.9 7135.4 7175.8 7203.7 7226.4 4588.8 4620.8 4855.0 5188.8 5281.0 4719.6 5119.3 5218.2 5271.4 5281.6 09:16:18 INFO - PROCESS | 1997 | 09:16:18 INFO - PROCESS | 1997 | [#4] prototype.html Cycles:180 Average:4544.76 Median:4872.73 stddev:1432.54 (29.4%) stddev-sans-first:1400.66 09:16:18 INFO - PROCESS | 1997 | Values: 298.6 303.1 304.9 315.4 317.5 5312.8 5475.3 5572.3 5703.7 5752.9 4835.8 5460.0 5560.0 5606.4 5654.0 4246.8 4298.8 4315.3 4315.6 4316.6 3479.7 3824.2 4172.2 4280.9 4331.6 4046.5 4163.2 4237.9 4243.4 4262.0 3484.6 3868.5 4257.4 4291.1 4300.8 3113.6 3706.9 3716.5 3735.3 3737.0 3987.7 4651.9 5269.8 5372.9 5476.3 4081.4 4303.8 4665.7 4899.1 4957.3 4856.5 5105.5 5758.0 5965.9 6051.5 3328.3 3416.5 3742.0 3767.5 4075.2 6169.5 6271.7 6299.2 6304.0 6307.4 3516.7 4073.0 4157.9 4165.3 4168.5 3639.8 3643.9 3859.9 4072.6 4208.2 4313.2 4721.7 4961.9 4964.0 4979.6 5057.3 5727.3 5996.9 6001.3 6042.9 1311.7 1416.9 1436.4 1450.2 1461.8 724.1 725.4 773.5 863.4 899.9 3951.7 4614.1 4638.8 4672.8 4717.8 4463.5 4761.6 5150.4 5219.4 5240.9 4219.1 4655.2 4668.0 4670.3 4718.4 2308.9 2495.0 2547.8 2736.1 2736.6 4423.6 4771.5 4861.8 5346.8 5381.5 4074.7 4750.3 5346.7 5375.7 5382.2 4668.9 4744.3 5073.8 5322.6 5324.0 4521.3 4749.3 5184.6 5213.4 5232.3 4548.9 5066.8 5157.2 5171.0 5551.5 5112.4 5639.9 6002.4 6412.3 6469.7 3664.7 3754.8 3828.5 4094.5 4106.8 4999.6 6047.8 6126.0 6235.8 6260.7 6012.2 6037.2 6063.4 6080.6 6115.4 5320.9 5689.9 6064.6 6065.7 6122.0 4883.7 4912.3 5378.7 5885.0 5960.0 6030.4 6031.5 6063.9 6073.8 6099.9 4947.0 5688.7 5845.3 5888.5 5969.9 09:16:18 INFO - PROCESS | 1997 | 09:16:18 INFO - PROCESS | 1997 | [#5] yui.html Cycles:180 Average:23092.38 Median:3640.44 stddev:34944.59 (959.9%) stddev-sans-first:35002.33 09:16:18 INFO - PROCESS | 1997 | Values: 746.1 774.8 789.0 807.3 818.9 15281.6 15812.4 15963.9 16027.2 16095.2 14074.6 14471.3 14587.2 14606.2 14630.3 699.2 849.4 871.4 876.3 876.4 877.0 891.0 891.4 892.8 893.3 712.8 939.9 941.3 942.1 942.2 904.3 922.7 924.3 938.2 938.5 670.3 670.9 678.7 692.4 692.5 14668.0 14716.9 14978.9 15149.4 15223.1 14869.1 14925.0 14963.2 14976.3 15324.9 11822.2 12158.6 12423.5 12433.9 12482.0 3880.6 3915.3 4103.7 4128.9 4132.6 112292.0 113533.0 113878.0 114898.4 117471.4 11523.4 11648.5 11672.6 11700.0 11990.6 19698.7 20091.5 21333.8 24370.0 24570.9 6971.0 8244.4 8311.7 8393.4 8420.2 4434.2 4511.9 4514.4 4572.8 4742.9 3585.4 3695.4 3696.1 3930.7 4110.2 728.2 737.9 748.0 748.0 752.5 522.4 576.4 688.1 699.0 706.9 9434.5 9566.2 9846.4 9962.2 10250.5 580.0 677.4 691.2 708.7 712.8 4351.6 4648.1 4993.7 5020.9 5026.8 81178.0 95330.0 111609.0 147306.0 155474.0 98145.5 107343.5 111990.0 112744.0 113489.0 99808.5 100132.5 100679.0 100838.0 102787.0 9620.8 9989.1 10167.6 10196.0 10249.5 55794.0 55941.0 58559.4 59830.7 59883.0 67624.0 68617.3 77713.8 84962.3 95132.0 10938.3 13783.9 13919.0 13989.7 14148.7 15141.7 15174.5 15213.2 15767.7 15972.1 11431.5 13982.0 14209.0 14376.8 14818.6 13763.7 14027.0 14187.4 14288.6 14482.3 13795.6 14077.2 14272.5 14428.1 14463.0 10995.0 11050.5 11515.4 11610.3 11771.9 11251.5 11530.9 11555.5 11703.2 11780.3 09:16:18 INFO - PROCESS | 1997 | -------- Summary: end -------- 09:16:18 INFO - PROCESS | 1997 | 09:16:19 INFO - TEST-INFO | 1997: exit 0 09:16:19 INFO - TEST-OK | dromaeo_css | took 1113383ms 09:16:19 INFO - TEST-START | kraken 09:16:19 INFO - operating with platform_type : mac_ 09:16:19 INFO - Initialising browser for kraken test... 09:16:19 INFO - TEST-INFO | started process 2002 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpEaUSWf/profile http://localhost:49403/getInfo.html) 09:16:21 INFO - PROCESS | 2002 | JavaScript error: , line 0: uncaught exception: undefined 09:16:22 INFO - PROCESS | 2002 | __metrics Screen width/height:1600/1200 09:16:22 INFO - PROCESS | 2002 | colorDepth:24 09:16:22 INFO - PROCESS | 2002 | Browser inner width/height: 1024/689 09:16:22 INFO - PROCESS | 2002 | __metrics 09:16:22 ERROR - PROCESS | 2002 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:16:23 INFO - TEST-INFO | 2002: exit 0 09:16:23 INFO - Browser initialized. 09:16:23 INFO - Running cycle 1/1 for kraken test... 09:16:23 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpEaUSWf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:35 INFO - PROCESS | 2004 | RSS: Main: 256290816 09:16:35 INFO - PROCESS | 2004 | 09:16:38 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49403/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:39 INFO - PROCESS | 2004 | RSS: Main: 269967360 09:16:39 INFO - PROCESS | 2004 | 09:16:41 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49403/tests/kraken/driver.html?testName=audio-dft) 09:16:42 INFO - PROCESS | 2004 | RSS: Main: 277405696 09:16:42 INFO - PROCESS | 2004 | 09:16:46 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49403/tests/kraken/driver.html?testName=audio-fft) 09:16:46 INFO - PROCESS | 2004 | RSS: Main: 281317376 09:16:46 INFO - PROCESS | 2004 | 09:16:48 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49403/tests/kraken/driver.html?testName=audio-oscillator) 09:16:49 INFO - PROCESS | 2004 | RSS: Main: 282529792 09:16:49 INFO - PROCESS | 2004 | 09:16:51 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:52 INFO - PROCESS | 2004 | RSS: Main: 284381184 09:16:52 INFO - PROCESS | 2004 | 09:16:55 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49403/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:55 INFO - PROCESS | 2004 | RSS: Main: 284897280 09:16:55 INFO - PROCESS | 2004 | 09:16:58 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49403/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:59 INFO - PROCESS | 2004 | RSS: Main: 285126656 09:16:59 INFO - PROCESS | 2004 | 09:17:02 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49403/tests/kraken/driver.html?testName=json-parse-financial) 09:17:03 INFO - PROCESS | 2004 | RSS: Main: 285237248 09:17:03 INFO - PROCESS | 2004 | 09:17:04 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:17:05 INFO - PROCESS | 2004 | RSS: Main: 285011968 09:17:05 INFO - PROCESS | 2004 | 09:17:07 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49403/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:17:08 INFO - PROCESS | 2004 | RSS: Main: 284708864 09:17:08 INFO - PROCESS | 2004 | 09:17:10 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:17:11 INFO - PROCESS | 2004 | RSS: Main: 285184000 09:17:11 INFO - PROCESS | 2004 | 09:17:13 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:14 INFO - PROCESS | 2004 | RSS: Main: 285278208 09:17:14 INFO - PROCESS | 2004 | 09:17:17 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:18 INFO - PROCESS | 2004 | RSS: Main: 285249536 09:17:18 INFO - PROCESS | 2004 | 09:17:19 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49403/tests/kraken/driver.html?testName=ai-astar) 09:17:20 INFO - PROCESS | 2004 | RSS: Main: 285974528 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | __start_tp_report 09:17:20 INFO - PROCESS | 2004 | _x_x_mozilla_page_load 09:17:20 INFO - PROCESS | 2004 | _x_x_mozilla_page_load_details 09:17:20 INFO - PROCESS | 2004 | |i|pagename|runs| 09:17:20 INFO - PROCESS | 2004 | |0;ai-astar;117;134;164;176;119;119;101;120;116;118 09:17:20 INFO - PROCESS | 2004 | |1;audio-beat-detection;143;113;132;164;99;146;148;142;197;107 09:17:20 INFO - PROCESS | 2004 | |2;audio-dft;195;201;208;248;279;258;198;198;201;203 09:17:20 INFO - PROCESS | 2004 | |3;audio-fft;69;88;89;147;52;72;57;51;139;83 09:17:20 INFO - PROCESS | 2004 | |4;audio-oscillator;70;72;131;62;64;111;108;86;91;148 09:17:20 INFO - PROCESS | 2004 | |5;imaging-gaussian-blur;93;93;135;116;93;90;94;90;93;90 09:17:20 INFO - PROCESS | 2004 | |6;imaging-darkroom;99;156;92;158;152;98;98;101;98;147 09:17:20 INFO - PROCESS | 2004 | |7;imaging-desaturate;77;77;132;152;124;144;154;147;93;91 09:17:20 INFO - PROCESS | 2004 | |8;json-parse-financial;57;58;56;58;57;58;56;56;57;57 09:17:20 INFO - PROCESS | 2004 | |9;json-stringify-tinderbox;73;71;76;74;89;76;78;73;79;111 09:17:20 INFO - PROCESS | 2004 | |10;stanford-crypto-aes;88;103;104;84;85;86;87;83;80;73 09:17:20 INFO - PROCESS | 2004 | |11;stanford-crypto-ccm;134;135;138;148;127;149;137;140;177;137 09:17:20 INFO - PROCESS | 2004 | |12;stanford-crypto-pbkdf2;199;229;215;167;163;165;164;163;166;167 09:17:20 INFO - PROCESS | 2004 | |13;stanford-crypto-sha256-iterative;68;67;68;66;64;68;66;68;67;67 09:17:20 INFO - PROCESS | 2004 | __end_tp_report 09:17:20 INFO - PROCESS | 2004 | __start_cc_report 09:17:20 INFO - PROCESS | 2004 | _x_x_mozilla_cycle_collect,1145 09:17:20 INFO - PROCESS | 2004 | __end_cc_report 09:17:20 INFO - PROCESS | 2004 | __startTimestamp1469204240005__endTimestamp 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | ------- Summary: start ------- 09:17:20 INFO - PROCESS | 2004 | Number of tests: 14 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#0] ai-astar Cycles:10 Average:128.40 Median:119.50 stddev:23.46 (19.6%) stddev-sans-first:24.52 09:17:20 INFO - PROCESS | 2004 | Values: 117.0 134.0 164.0 176.0 119.0 119.0 101.0 120.0 116.0 118.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:147.00 stddev:28.85 (19.6%) stddev-sans-first:30.57 09:17:20 INFO - PROCESS | 2004 | Values: 143.0 113.0 132.0 164.0 99.0 146.0 148.0 142.0 197.0 107.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#2] audio-dft Cycles:10 Average:218.90 Median:205.50 stddev:30.63 (14.9%) stddev-sans-first:31.25 09:17:20 INFO - PROCESS | 2004 | Values: 195.0 201.0 208.0 248.0 279.0 258.0 198.0 198.0 201.0 203.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#3] audio-fft Cycles:10 Average:84.70 Median:70.50 stddev:33.73 (47.9%) stddev-sans-first:35.30 09:17:20 INFO - PROCESS | 2004 | Values: 69.0 88.0 89.0 147.0 52.0 72.0 57.0 51.0 139.0 83.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:67.00 stddev:29.49 (44.0%) stddev-sans-first:29.94 09:17:20 INFO - PROCESS | 2004 | Values: 70.0 72.0 131.0 62.0 64.0 111.0 108.0 86.0 91.0 148.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#5] imaging-gaussian-blur Cycles:10 Average:98.70 Median:93.00 stddev:14.89 (16.0%) stddev-sans-first:15.65 09:17:20 INFO - PROCESS | 2004 | Values: 93.0 93.0 135.0 116.0 93.0 90.0 94.0 90.0 93.0 90.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#6] imaging-darkroom Cycles:10 Average:119.90 Median:95.00 stddev:28.93 (30.4%) stddev-sans-first:29.68 09:17:20 INFO - PROCESS | 2004 | Values: 99.0 156.0 92.0 158.0 152.0 98.0 98.0 101.0 98.0 147.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#7] imaging-desaturate Cycles:10 Average:119.10 Median:115.50 stddev:31.46 (27.2%) stddev-sans-first:29.44 09:17:20 INFO - PROCESS | 2004 | Values: 77.0 77.0 132.0 152.0 124.0 144.0 154.0 147.0 93.0 91.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 09:17:20 INFO - PROCESS | 2004 | Values: 57.0 58.0 56.0 58.0 57.0 58.0 56.0 56.0 57.0 57.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:76.00 stddev:11.99 (15.8%) stddev-sans-first:12.45 09:17:20 INFO - PROCESS | 2004 | Values: 73.0 71.0 76.0 74.0 89.0 76.0 78.0 73.0 79.0 111.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:84.50 stddev:9.55 (11.3%) stddev-sans-first:10.12 09:17:20 INFO - PROCESS | 2004 | Values: 88.0 103.0 104.0 84.0 85.0 86.0 87.0 83.0 80.0 73.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:139.00 stddev:13.81 (9.9%) stddev-sans-first:14.33 09:17:20 INFO - PROCESS | 2004 | Values: 134.0 135.0 138.0 148.0 127.0 149.0 137.0 140.0 177.0 137.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:167.00 stddev:24.90 (14.9%) stddev-sans-first:25.42 09:17:20 INFO - PROCESS | 2004 | Values: 199.0 229.0 215.0 167.0 163.0 165.0 164.0 163.0 166.0 167.0 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - PROCESS | 2004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.29 (1.9%) stddev-sans-first:1.30 09:17:20 INFO - PROCESS | 2004 | Values: 68.0 67.0 68.0 66.0 64.0 68.0 66.0 68.0 67.0 67.0 09:17:20 INFO - PROCESS | 2004 | -------- Summary: end -------- 09:17:20 INFO - PROCESS | 2004 | 09:17:20 INFO - TEST-INFO | 2004: exit 0 09:17:21 INFO - TEST-OK | kraken | took 61486ms 09:17:21 INFO - SUITE-END | took 1174s 09:17:21 INFO - Completed test suite (00:19:35) 09:17:21 INFO - javascript benchmark 09:17:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7425.460769446507, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2838.517452033155, 3395.660433956604, 3406.437937740273, 3440.7591468597193, 3443.845026973786, 5763.74063167158, 5857.7364018619155, 5917.674527900964, 5938.46553810157, 5962.970185149074, 5717.742701578429, 5870.236869206997, 5900.380460051686, 5913.379095195007, 5977.701114944246, 5230.816921407742, 5291.86770330741, 5367.651102678314, 5379.81170659027, 5411.540019098381, 5327.573794096483, 5442.91835622466, 5459.781608735646, 5477.20580515825, 5547.084731019397, 5229.895402091975, 5318.149096144598, 5345.118055520835, 5353.785848566053, 5406.648567843077, 5353.732313384316, 5382.165764306539, 5383.542398896098, 5394.703291318976, 5403.405625381205, 5297.973510132463, 5317.069512835238, 5346.134310669381, 5394.568434525228, 5422.267993820823, 4471.575200355961, 5760.596758226926, 5927.288725352985, 5939.109133629947, 6059.48494377974, 6214.223222097238, 6228.813135605939, 6259.843503912393, 6267.811965641038, 6272.1219029335925, 6321.051842223657, 6325.462335701471, 6330.683465826736, 6348.555601107924, 6359.682015899187, 5913.645181289136, 5982.97008514959, 6044.214252147192, 6060.969695151584, 6143.907841382383, 6353.078803573456, 6393.264774550986, 6407.13503677007, 6407.231132264065, 6409.9679501602195, 6174.0, 6179.876402471926, 6202.5658203925295, 6229.1590635264565, 6244.188255526752, 6172.567920245539, 6222.408871157233, 6227.221597300338, 6304.779332723424, 6352.428281454691, 6164.599301045508, 6169.321374648785, 6222.937770622327, 6240.375962403723, 6250.874982500415, 6226.782062627877, 6229.750809967551, 6230.6573138476915, 6239.688015599293, 6254.312025677172, 4950.628702847301, 5032.773525191302, 5042.344495215599, 5057.9378330551, 5127.384713834289, 4567.177907976529, 4590.334401511762, 4599.471060827981, 4602.815887364468, 4640.025594625099, 5977.043673012297, 6089.725962331617, 6089.8477538061015, 6092.086187071975, 6092.878142437126, 5321.680699158062, 5802.723400851806, 6234.096056071844, 6237.812865614039, 6313.053042043638, 4734.55021772931, 5294.152935530296, 6070.119832624245, 6074.878502429927, 6089.056196289582, 5574.749136288877, 5576.637518561281, 5588.3573389060775, 5598.552115830724, 5604.4395560444445, 6260.311365749764, 6408.711607977559, 6446.0975463434215, 6522.967385163044, 6523.543351965412, 5800.187973683604, 5857.447776339188, 6349.6507692077375, 6358.395952384516, 6387.041943708481, 5412.052890744183, 5955.374685657944, 6335.922893108275, 6490.286068532363, 6518.869622607616, 6050.7277172526465, 6111.257501106225, 6150.200473938359, 6169.475594574512, 6296.33888441707, 6295.842603934938, 6323.304436512072, 6325.746970121144, 6327.96836015817, 6337.6197428154455, 5135.974320128375, 6193.071039344134, 6200.968995154995, 6212.565120441525, 6241.469475094668, 4709.929351059805, 6102.474381404649, 6121.75750147007, 6179.528188724546, 6254.405831446005, 6004.399560044136, 6014.969925150346, 6084.513238940785, 6097.240212207355, 6125.388069147199, 6202.255729312511, 6226.3151053385, 6231.345708700703, 6240.781572644935, 6248.343923887926, 6089.238845144357, 6109.725062372293, 6150.10823430609, 6153.72308246139, 6154.538409619386], "value": 5775.455824079385, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.6531966344904, 484.49854400695267, 494.09580467744007, 537.6102325813786, 565.7312776431198, 39508.60491395089, 41812.790936045356, 42270.0, 42274.0, 42365.36451953215, 42465.0, 42748.717538473895, 42833.7858310708, 42959.78520107395, 42987.140257194835, 7786.922130778705, 8972.801663592429, 9648.903510964907, 9670.709878703632, 9681.854772178423, 9498.715038548855, 9537.33238673293, 9599.376040557341, 9662.0, 9691.612335506572, 8232.1356257593, 9588.424694518317, 9699.127078562928, 9758.951205243964, 9761.560729767178, 9689.127978481934, 9717.708468745948, 9738.269629777795, 9745.707628771148, 9750.853737193947, 9717.31978761487, 9783.804323913553, 9803.607855685836, 9829.311948163631, 9833.508324583741, 40403.59596404028, 40463.1907361854, 40802.18395632071, 40867.0, 41056.79471602623, 3433.6909678128836, 3524.823758812049, 3531.3820081485637, 3679.411294192943, 4405.691601587891, 32098.518522222184, 33278.334433311444, 33287.83356083228, 33468.99593012214, 33497.33005339879, 3317.717993970515, 3383.9661603383897, 3408.471686888536, 3426.554547908756, 3430.1596108953217, 475156.0, 510341.0, 538125.3093734545, 538282.0, 539556.0, 64462.67768661126, 64779.0, 65191.674041629485, 65279.673601631686, 65377.0, 65883.0, 68062.65968670126, 68518.0, 68581.0, 68651.31348686549, 16916.407925722542, 16999.74500382495, 17296.481105566854, 17297.962122272704, 17309.874858134182, 13058.477660893648, 13117.868821311855, 13153.73692526144, 13158.934205328913, 13178.736425271632, 17329.913350433166, 18160.0, 18205.089745512938, 18253.45239642813, 18262.36081737133, 7056.294370562902, 7156.177039640508, 7223.747168849065, 7294.452916031319, 7314.963425182947, 848.5545088828414, 919.9264058875274, 998.5306905754284, 1031.4997226345217, 1078.164422572497, 26877.328066798487, 27120.0, 28150.577741333895, 31535.684643153276, 31604.367912641617, 956.268454632207, 1075.1398880895254, 1101.7245688577855, 1104.2932523185168, 1105.2484310668822, 15782.68434631301, 16157.4344897928, 16324.93887897283, 16536.6692666146, 16711.498655040366, 597632.0236797663, 713001.0, 717454.0, 717970.0, 722940.0, 61276.0, 63016.68491657513, 63283.68358158272, 63480.047799282125, 63540.682296588224, 1398.2309729648653, 1403.7262733767022, 1451.477468111479, 1452.6658868460102, 1453.396840311259, 26903.865480673256, 31072.53391199179, 31380.0, 31760.68239317577, 32240.67759322377, 42107.0, 45122.0, 54268.914621708136, 55094.72452637711, 55304.89390212254, 602663.0, 611408.0, 611625.0, 612520.0, 613074.0, 27175.86412067927, 27850.0, 27946.580801288404, 28075.157745267676, 28302.716972830007, 48933.26600101073, 49371.0, 50124.74937625288, 50697.49302506928, 51028.74485627548, 36023.63976360203, 39392.81821545358, 42799.5720042808, 43152.56847431485, 43799.56200437955, 41230.79384603058, 41344.79327603343, 41431.1713765717, 42323.57676423196, 42646.0, 40388.0, 40624.1875162501, 40858.591414086666, 41012.0, 42575.0, 32189.517157243128, 36302.636973629924, 36443.60166988482, 36926.815365923, 36953.26093478169, 22076.88961555182, 26618.7338126624, 26815.597766033134, 27057.59413608837, 27372.86313568499], "value": 20654.552566134575, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.8266514738073, 369.9667029967304, 385.7820331512696, 392.58582195783436, 403.2660557784833, 16972.915135424322, 19178.90410547947, 20622.793772062294, 20661.483462913435, 21050.0, 20228.69656955143, 20442.08010639521, 20811.479713007182, 20993.265235716754, 21056.368308950718, 4492.910141797162, 5023.522765337306, 5824.504917082042, 5931.317898441691, 6014.3985601439945, 5993.0710739835395, 6042.758289668408, 6058.757649694007, 6060.2424696912885, 6062.696865156725, 5720.456556627114, 5847.122931560258, 5856.648601083949, 5900.940990590082, 5936.786804033099, 5763.567732420043, 5777.959967205901, 5866.911996320037, 5867.061270196769, 5882.441168089046, 4970.552650261494, 4990.675606085629, 5047.899042019176, 5150.690958542499, 5157.149070403379, 24999.250022499353, 25354.619680704804, 25393.873030634728, 25599.872000640065, 25872.611910821164, 2173.6956826044366, 2265.988670056656, 2475.0965897447304, 2607.765301122908, 2968.1392396205074, 15024.023438476464, 15654.686906261924, 15766.76349854753, 15875.52373428799, 15985.92007039969, 1845.7877344105466, 1871.4946964319693, 1917.5781328107794, 1931.7102434634776, 1932.7680678318552, 109999.0, 113280.4335978323, 113490.0, 113913.43043284814, 114908.42545787217, 10381.84427233592, 10440.0, 10535.84196237057, 10821.9458902705, 11053.723656908482, 13035.739285214433, 13402.59792206216, 13404.798928016087, 13408.798868016987, 13413.262270575016, 8387.62255698495, 8592.8711069334, 8626.223639872442, 8797.51613661242, 8798.208161265517, 7567.848643027109, 8494.06565277819, 8775.42959707617, 8794.0, 8899.688510902217, 6339.239291284983, 6491.740330386826, 6523.412892839572, 6524.641144737085, 6548.967255163789, 1731.9913400432918, 1767.301915743274, 1833.5966087460738, 1856.5729882127187, 1901.0684764465313, 909.7270818754347, 911.3893691226893, 940.2478017585904, 965.3146266151111, 1019.1642852860731, 22141.446463838212, 22195.33413997583, 22408.66387004196, 22440.438989025406, 22600.66099008516, 967.5355829201882, 980.6518685866557, 983.4296108257194, 984.247051005981, 1024.062982371137, 11461.885381146249, 12369.814452783216, 12414.565490207799, 12440.875591244152, 12571.937140314423, 567973.0, 572434.0, 575265.0, 578959.0, 584285.0, 78476.0, 92977.0, 116941.0, 120794.96025198705, 133929.0, 843.9535825529532, 982.8427451607708, 999.165696643311, 1033.204432586904, 1035.7203555040096, 14143.787843182155, 15335.156566388956, 18330.450086497425, 18519.629607408046, 18840.811591883907, 43713.907152321444, 47586.524134759595, 50972.72568185677, 53313.46686533085, 53840.461595383546, 75430.62284688541, 75722.0, 76524.0, 76810.0, 77103.61448192723, 7611.124720656974, 7727.42044346665, 7818.140004599603, 7845.058592968652, 7918.485298455812, 9971.252156088178, 12083.69790755203, 12179.147459678092, 12186.878131218575, 12281.815772763237, 10453.059224669816, 10623.89376106229, 11030.117590592572, 11036.11711063129, 11165.660120785233, 10102.0, 11003.944980275048, 11022.50398732075, 11109.777804443704, 11244.887551124384, 11084.61203857861, 11201.15991300672, 11366.204365694322, 11393.373364464702, 11473.541058357907, 7109.933509973545, 7537.472376933562, 7988.320992715684, 8068.798280043045, 8249.711260106107, 10325.32885362449, 10627.787444250916, 11053.557857685924, 11106.888931110585, 11199.160062995144], "value": 9621.70121709989, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.5570084675444, 1564.8278689344172, 1734.2629382512437, 1794.9730754038692, 1910.3600293901543, 7983.682692355769, 8517.361197910159, 8590.87113693295, 8963.103689631042, 9001.864972025416, 7159.212486626467, 7796.454248202628, 8087.19128087191, 8159.959200204005, 8776.297896168307, 2377.2274010946426, 2410.457647029422, 2414.7223069347074, 2414.915477958272, 2419.9274021779374, 2283.6346184610466, 2358.3396648938324, 2360.6104992676187, 2362.65741467488, 2383.52329534093, 2348.5655153796515, 2360.527894421114, 2382.9642555361684, 2397.1729753235195, 2406.133791834938, 2084.551821358408, 2279.4301424643922, 2294.4378627236265, 2359.976400235993, 2396.7962723168553, 2338.672585837984, 2371.833971621987, 2381.2499062795164, 2386.7851893329685, 2389.330987323535, 8881.378303518757, 8906.332025098143, 8919.375643704943, 8979.281657467387, 8991.55042247885, 5297.629165958385, 5425.647332923348, 5459.972700136514, 5462.071447853875, 5470.9452905470835, 3561.0919215599856, 3667.1015601177614, 3683.594804571495, 3704.8888533344043, 3735.962640373589, 1088.5917780832187, 1089.9128069754402, 1097.1716354152643, 1100.031971864762, 1104.6354702948088, 11594.304341739522, 11650.708732281591, 11657.825132623017, 11696.719139767749, 11726.824097638542, 4440.555944405598, 4551.8634440966825, 4660.021395506914, 4683.039976804746, 4697.107549565571, 9206.401583897024, 9214.0, 9263.212626926652, 9264.95367523158, 9267.351285410092, 5224.346956630421, 5317.0, 5317.73411329432, 5326.840194794162, 5342.2787923630585, 4502.707324023928, 4844.249141383091, 4963.851084467472, 4982.651214415028, 4999.375078115236, 3838.481804956295, 3850.7882066486613, 3956.823746939172, 3957.742746721454, 4001.0, 1179.4515550269166, 1191.6127258640977, 1194.092489707811, 1194.396829601046, 1202.5971299614553, 814.9144339844231, 844.6199210355364, 905.977350566228, 952.6522819170953, 1004.492731170754, 5011.774470148852, 5939.138824870456, 6104.755809767559, 6232.220972378453, 6330.430261276507, 419.5929947950483, 445.9876081295506, 448.23352067964146, 448.93714879916837, 459.68970944612255, 4095.2219078375015, 4149.170165966819, 4162.2299874522705, 4259.382389553497, 4286.421333119989, 10707.411092389837, 10709.143268538499, 10732.678019659423, 10888.455577221266, 10916.0, 9953.751156221153, 10635.308704934154, 10710.732231694114, 10836.458177091272, 10940.945295273472, 8065.677372905018, 8356.665733370597, 8356.70471076984, 8365.745138229315, 8370.581470926429, 5840.429516793607, 5863.589548731547, 6057.757689692363, 6267.655278959701, 6329.90505142414, 9214.907850921405, 9988.250881184085, 10180.185585153318, 10228.744281393025, 10268.845967310646, 9558.235341172829, 9607.183389411979, 9689.70930872075, 9753.366031207948, 9765.462899540593, 7036.437085033082, 7530.322270995636, 7696.884546731915, 8010.519368837889, 8174.019117705676, 8291.58542072906, 8342.624581893708, 8363.163683631588, 8495.74512764618, 8498.405111642373, 7458.440616953859, 7659.272369124924, 7693.923060769321, 7732.110807257238, 7769.028871391076, 6286.339934307015, 6368.949123394588, 7034.050403195503, 7053.717851285891, 7481.476296659399, 7079.929200708133, 7135.393491553276, 7175.784726458214, 7203.675834587351, 7226.4218862491925, 4588.793504292248, 4620.821690468909, 4855.0, 5188.844334669966, 5281.049411106038, 4719.622430205644, 5119.334486516729, 5218.217267409919, 5271.420143784104, 5281.60387970896], "value": 4504.780071317688, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.5775128193606, 303.08015173947075, 304.9161480592837, 315.4212020941572, 317.5173735921398, 5312.78748850046, 5475.342958844944, 5572.300448363248, 5703.657780533171, 5752.942470575298, 4835.75821208939, 5459.972700136504, 5560.0, 5606.383297837235, 5654.0493529732275, 4246.810892949979, 4298.828046878121, 4315.266404711198, 4315.561707635176, 4316.589923957219, 3479.6868281854627, 3824.2351529694033, 4172.18642364739, 4280.914381712364, 4331.610155086041, 4046.453728746611, 4163.229802486535, 4237.936430953539, 4243.427137336451, 4262.0, 3484.5992710838323, 3868.4777555030273, 4257.425247591582, 4291.141771645684, 4300.838773531161, 3113.595232619745, 3706.8887933362043, 3716.4611131385795, 3735.290294843971, 3736.981315093407, 3987.6840642587877, 4651.930221046687, 5269.762860671279, 5372.946270537283, 5476.342838859362, 4081.3877918312196, 4303.8063287151845, 4665.673402861801, 4899.093667671492, 4957.256411538262, 4856.490068542823, 5105.514976077304, 5758.049921762904, 5965.850853728648, 6051.515878729735, 3328.3176948725695, 3416.4704470806814, 3742.0, 3767.5102236709326, 4075.246079475277, 6169.506439484875, 6271.749130034793, 6299.181106456177, 6304.0, 6307.391615138111, 3516.7339757687214, 4073.0021144819116, 4157.937630935538, 4165.250254954138, 4168.499780026416, 3639.7816131032223, 3643.927121457556, 3859.9192226176156, 4072.615310794344, 4208.242516347026, 4313.16690406576, 4721.716696998191, 4961.8511444656715, 4964.0, 4979.57673597741, 5057.291979122926, 5727.31272247333, 5996.8800623988145, 6001.3098493672915, 6042.939570604326, 1311.6851955530603, 1416.9160592147016, 1436.4397884824928, 1450.166154461168, 1461.751502244621, 724.0876495615457, 725.365305357812, 773.4547144263281, 863.4387648028707, 899.8976254088689, 3951.723379363417, 4614.100250451197, 4638.79657162845, 4672.76636168197, 4717.764111794397, 4463.486699029589, 4761.642876784255, 5150.399048480494, 5219.42586315505, 5240.895182096337, 4219.1139860629, 4655.185342565038, 4668.0, 4670.342028579873, 4718.386609740781, 2308.9422764431024, 2494.9625755613315, 2547.8216524843456, 2736.1107640017076, 2736.6305548750665, 4423.646108311327, 4771.4512831024185, 4861.805527778849, 5346.839594812084, 5381.461853814587, 4074.735142215806, 4750.311204875274, 5346.679199248058, 5375.650582712111, 5382.192671099367, 4668.85993420198, 4744.272043574889, 5073.847784566469, 5322.574194064466, 5324.0, 4521.321801729767, 4749.3113498541825, 5184.637075404686, 5213.435969209298, 5232.319798426181, 4548.863534093983, 5066.797328106982, 5157.226416037624, 5171.0, 5551.500364967173, 5112.3865136183895, 5639.885043108834, 6002.429769171922, 6412.274783217207, 6469.7412103515335, 3664.725145614036, 3754.831032603485, 3828.4640150378414, 4094.488188976378, 4106.7946602670345, 4999.575036121971, 6047.758089676364, 6126.0, 6235.781747638811, 6260.655663938527, 6012.218411606463, 6037.215162028908, 6063.423974722395, 6080.635161890301, 6115.357887421935, 5320.893582128413, 5689.914651280152, 6064.636121832704, 6065.727042283196, 6122.020476723703, 4883.658143929891, 4912.336834527436, 5378.677279363251, 5885.0, 5959.970200148971, 6030.3668114847305, 6031.457168854648, 6063.909041364472, 6073.787417440369, 6099.9390006099375, 4946.975265123651, 5688.7440065198, 5845.298564172156, 5888.4700376966275, 5969.85085369258], "value": 4088.2545679685654, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.1009483572296, 774.8024253815277, 788.9940326084242, 807.2532907060969, 818.9262966333029, 15281.617959551017, 15812.367505299775, 15963.920180399082, 16027.198640067994, 16095.195240237985, 14074.577762667112, 14471.276436178176, 14587.197704126269, 14606.19665918374, 14630.268486575682, 699.2029086841005, 849.4054162086534, 871.3508436215029, 876.3339861705102, 876.3996662286354, 877.0308808766317, 890.9554522273893, 891.4205766251923, 892.7768057985504, 893.3478560650728, 712.7612249896291, 939.9389039712431, 941.3081385181886, 942.0579420579421, 942.185009966381, 904.2856143646577, 922.6862866625313, 924.3160061554469, 938.2212763406391, 938.5448057692014, 670.3464122480591, 670.8658268346351, 678.6844117485343, 692.4322055914153, 692.5394612582627, 14668.0, 14716.926415367961, 14978.850211497964, 15149.394024239018, 15223.086614803036, 14869.098455521429, 14925.0, 14963.177025263607, 14976.326065327086, 15324.923375383052, 11822.172447928648, 12158.5744498943, 12423.503059877594, 12433.875661243454, 12482.0, 3880.631340022693, 3915.295246855565, 4103.733257338294, 4128.876133715993, 4132.648724858361, 112292.0, 113533.0, 113878.0, 114898.42550787193, 117471.4126429371, 11523.423828808694, 11648.475818588184, 11672.649820505398, 11700.0, 11990.580329688593, 19698.70451943222, 20091.497712557302, 21333.78666213349, 24370.025198991843, 24570.87714561416, 6971.0, 8244.381671374671, 8311.6675332986, 8393.412461127662, 8420.242178203991, 4434.224010798098, 4511.8646440606835, 4514.367988481616, 4572.7713614319155, 4742.928856067162, 3585.4442561403025, 3695.4456831474954, 3696.1129328960856, 3930.7051971102283, 4110.17796440713, 728.1589763822793, 737.9151397589238, 747.9626018699153, 747.9738209162654, 752.5484709174451, 522.3575002746567, 576.3803910795912, 688.132952479869, 698.9685464154023, 706.8868980963022, 9434.528273586293, 9566.186874115778, 9846.359986600992, 9962.203023758082, 10250.487475626189, 579.982600521985, 677.4106527321163, 691.2051141187574, 708.7377670261933, 712.7505373119367, 4351.607485604576, 4648.1191377976875, 4993.650444468925, 5020.949790502048, 5026.84919452417, 81178.0, 95330.0466995335, 111609.0, 147306.0, 155474.0, 98145.50927245319, 107343.4632826831, 111990.0, 112744.0, 113489.0, 99808.50670226508, 100132.49933750284, 100678.99321006697, 100838.0, 102786.9999999985, 9620.84549854022, 9989.051040151175, 10167.644132455329, 10195.980401959745, 10249.538770755484, 55794.0, 55941.0, 58559.414405855394, 59830.70084649549, 59883.0, 67624.0, 68617.2845678842, 77713.83429248452, 84962.30075398581, 95132.0, 10938.289011214245, 13783.862161378658, 13919.025668203129, 13989.650258743206, 14148.736202207598, 15141.697166056398, 15174.468893588672, 15213.239338032832, 15767.68464630724, 15972.12153331578, 11431.485583148611, 13982.0, 14209.005369624027, 14376.751468491286, 14818.555443336718, 13763.655908602364, 14027.0, 14187.432502699776, 14288.642783930485, 14482.34829432657, 13795.586132416043, 14077.225752583297, 14272.500462483764, 14428.134311941318, 14463.0, 10994.982448485898, 11050.502727377127, 11515.366654834064, 11610.303381797119, 11771.941140294244, 11251.537300151256, 11530.94234528822, 11555.4800033997, 11703.180777345504, 11780.293182409083], "value": 7929.159727252532, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1616.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 134.0, 164.0, 176.0, 119.0, 119.0, 101.0, 120.0, 116.0, 118.0], "value": 128.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 113.0, 132.0, 164.0, 99.0, 146.0, 148.0, 142.0, 197.0, 107.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 201.0, 208.0, 248.0, 279.0, 258.0, 198.0, 198.0, 201.0, 203.0], "value": 218.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 88.0, 89.0, 147.0, 52.0, 72.0, 57.0, 51.0, 139.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 131.0, 62.0, 64.0, 111.0, 108.0, 86.0, 91.0, 148.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 135.0, 116.0, 93.0, 90.0, 94.0, 90.0, 93.0, 90.0], "value": 98.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 156.0, 92.0, 158.0, 152.0, 98.0, 98.0, 101.0, 98.0, 147.0], "value": 119.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 132.0, 152.0, 124.0, 144.0, 154.0, 147.0, 93.0, 91.0], "value": 119.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 58.0, 57.0, 58.0, 56.0, 56.0, 57.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 76.0, 74.0, 89.0, 76.0, 78.0, 73.0, 79.0, 111.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 103.0, 104.0, 84.0, 85.0, 86.0, 87.0, 83.0, 80.0, 73.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 138.0, 148.0, 127.0, 149.0, 137.0, 140.0, 177.0, 137.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 229.0, 215.0, 167.0, 163.0, 165.0, 164.0, 163.0, 166.0, 167.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 64.0, 68.0, 66.0, 68.0, 67.0, 67.0], "value": 66.9, "unit": "score"}]}]} 09:17:21 INFO - Return code: 0 09:17:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:17:21 ERROR - # TBPL SUCCESS # 09:17:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:21 INFO - 2016-07-22 09:17:21.320 screenresolution[2009:13108] starting screenresolution argv=screenresolution get 09:17:21 INFO - 2016-07-22 09:17:21.322 screenresolution[2009:13108] Display 0: 1600x1200x32@60 09:17:21 INFO - 2016-07-22 09:17:21.329 screenresolution[2010:13111] starting screenresolution argv=screenresolution list 09:17:21 INFO - Available Modes on Display 0 09:17:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:21 INFO - Intel Iris: 09:17:21 INFO - Chipset Model: Intel Iris 09:17:21 INFO - Type: GPU 09:17:21 INFO - Bus: Built-In 09:17:21 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:21 INFO - Vendor: Intel (0x8086) 09:17:21 INFO - Device ID: 0x0a2e 09:17:21 INFO - Revision ID: 0x0009 09:17:21 INFO - Displays: 09:17:21 INFO - Display: 09:17:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:21 INFO - Display Serial Number: 1600x1200 60 09:17:21 INFO - Main Display: Yes 09:17:21 INFO - Mirror: Off 09:17:21 INFO - Online: Yes 09:17:21 INFO - Rotation: Supported 09:17:21 INFO - Return code: 0 09:17:21 INFO - Running post-action listener: _resource_record_post_action 09:17:21 INFO - [mozharness: 2016-07-22 16:17:21.572417Z] Finished run-tests step (success) 09:17:21 INFO - Running post-run listener: _resource_record_post_run 09:17:21 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 294912; Write bytes: 708200448; Read time: 6; Write time: 1955 09:17:21 INFO - TinderboxPrint: CPU usage
54.4% 09:17:21 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 6 09:17:21 INFO - TinderboxPrint: I/O write bytes / time
708,200,448 / 1,955 09:17:21 INFO - TinderboxPrint: CPU idle
2,210.5 (45.6%) 09:17:21 INFO - TinderboxPrint: CPU system
989.4 (20.4%) 09:17:21 INFO - TinderboxPrint: CPU user
1,649.8 (34.0%) 09:17:21 INFO - TinderboxPrint: Swap in / out
408,236,032 / 0 09:17:21 INFO - install - Wall time: 37s; CPU: 55.0%; Read bytes: 393153024; Write bytes: 387893248; Read time: 31589; Write time: 790 09:17:21 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 294912; Write bytes: 297259008; Read time: 6; Write time: 1120 09:17:22 INFO - Running post-run listener: _upload_blobber_files 09:17:22 INFO - Blob upload gear active. 09:17:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:17:22 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 09:17:22 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:17:22 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:17:22 INFO - (blobuploader) - INFO - Open directory for files ... 09:17:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:17:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:24 INFO - (blobuploader) - INFO - Done attempting. 09:17:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:17:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:17:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:25 INFO - (blobuploader) - INFO - Done attempting. 09:17:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:17:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:17:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:28 INFO - (blobuploader) - INFO - Done attempting. 09:17:28 INFO - (blobuploader) - INFO - Iteration through files over. 09:17:28 INFO - Return code: 0 09:17:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:17:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:17:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65f3fcb340adad21df52ff19192789e756e9632352099c12ad9ca2c778720da4c03a97273a2bbab5c3319bf71fb56067bba62690fa03b7c0c9573b05eb0cb591", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8dc319378b31ec3867c2a49a14ae069c10206a6fcf27817b6663636801c06e023bfbb84d17ebc7f2f21bb33111b0ece19efc3e70350a6054cad5991130d5257", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d40b8246b6287062123c4d45ac886319fabe6b3190e9c90fde6b5e2008e1e2e8426f65cf3ac27e996c19327bfed753629c4a8ffb59703a6fbee18ac525a42a2"} 09:17:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:17:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:17:28 INFO - Contents: 09:17:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65f3fcb340adad21df52ff19192789e756e9632352099c12ad9ca2c778720da4c03a97273a2bbab5c3319bf71fb56067bba62690fa03b7c0c9573b05eb0cb591", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8dc319378b31ec3867c2a49a14ae069c10206a6fcf27817b6663636801c06e023bfbb84d17ebc7f2f21bb33111b0ece19efc3e70350a6054cad5991130d5257", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d40b8246b6287062123c4d45ac886319fabe6b3190e9c90fde6b5e2008e1e2e8426f65cf3ac27e996c19327bfed753629c4a8ffb59703a6fbee18ac525a42a2"} 09:17:28 INFO - Running post-run listener: copy_logs_to_upload_dir 09:17:28 INFO - Copying logs to upload dir... 09:17:28 INFO - mkdir: /builds/slave/test/build/upload/logs 09:17:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1343.120785 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 23 secs) (at 2016-07-22 09:17:28.124007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 09:17:28.127327) ========= 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.Pkea1jMpL1/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.WKOrGuTudK/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65f3fcb340adad21df52ff19192789e756e9632352099c12ad9ca2c778720da4c03a97273a2bbab5c3319bf71fb56067bba62690fa03b7c0c9573b05eb0cb591", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8dc319378b31ec3867c2a49a14ae069c10206a6fcf27817b6663636801c06e023bfbb84d17ebc7f2f21bb33111b0ece19efc3e70350a6054cad5991130d5257", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d40b8246b6287062123c4d45ac886319fabe6b3190e9c90fde6b5e2008e1e2e8426f65cf3ac27e996c19327bfed753629c4a8ffb59703a6fbee18ac525a42a2"} build_url:https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010908 build_url: 'https://queue.taskcluster.net/v1/task/LmlJ04ZfSk6Z-4qvO76ljw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65f3fcb340adad21df52ff19192789e756e9632352099c12ad9ca2c778720da4c03a97273a2bbab5c3319bf71fb56067bba62690fa03b7c0c9573b05eb0cb591", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c8dc319378b31ec3867c2a49a14ae069c10206a6fcf27817b6663636801c06e023bfbb84d17ebc7f2f21bb33111b0ece19efc3e70350a6054cad5991130d5257", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d40b8246b6287062123c4d45ac886319fabe6b3190e9c90fde6b5e2008e1e2e8426f65cf3ac27e996c19327bfed753629c4a8ffb59703a6fbee18ac525a42a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 09:17:28.159524) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:17:28.159838) ========= 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.Pkea1jMpL1/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.WKOrGuTudK/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005141 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 09:17:28.208744) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 09:17:28.209067) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 09:17:28.209385) ========= ========= Total master_lag: 0.17 =========