builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0272 starttime: 1470778263.71 results: success (0) buildid: 20160809121845 builduid: e9b42fe03e2b447294d1ce3ae51e171c revision: 6290767b211dc902629c99ac08be894b1c63d765 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:03.705869) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:03.706522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:03.706860) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:03.730598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:03.731160) ========= 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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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-08-09 14:31:03-- 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% 18.4M=0.001s 2016-08-09 14:31:03 (18.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127067 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:03.881264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:03.881590) ========= 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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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.024817 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:03.930622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-09 14:31:03.931002) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6290767b211dc902629c99ac08be894b1c63d765 --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 6290767b211dc902629c99ac08be894b1c63d765 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qLfn2N4aMy/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.9XCK4s4qQG/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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-08-09 14:31:04,016 truncating revision to first 12 chars 2016-08-09 14:31:04,016 Setting DEBUG logging. 2016-08-09 14:31:04,016 attempt 1/10 2016-08-09 14:31:04,016 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6290767b211d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 14:31:05,286 unpacking tar archive at: fx-team-6290767b211d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.557121 ========= master_lag: 0.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-09 14:31:05.938012) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:05.938379) ========= script_repo_revision: 6290767b211dc902629c99ac08be894b1c63d765 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:05.938793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:05.939115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 14:31:05.957218) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-09 14:31:05.957814) ========= /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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:31:06 INFO - MultiFileLogger online at 20160809 14:31:06 in /builds/slave/test 14:31:06 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 14:31:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:31:06 INFO - {'append_to_log': False, 14:31:06 INFO - 'base_work_dir': '/builds/slave/test', 14:31:06 INFO - 'blob_upload_branch': 'Fx-Team', 14:31:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:31:06 INFO - 'branch': 'Fx-Team', 14:31:06 INFO - 'buildbot_json_path': 'buildprops.json', 14:31:06 INFO - 'config_files': ('talos/mac_config.py',), 14:31:06 INFO - 'default_actions': ('clobber', 14:31:06 INFO - 'read-buildbot-config', 14:31:06 INFO - 'download-and-extract', 14:31:06 INFO - 'populate-webroot', 14:31:06 INFO - 'create-virtualenv', 14:31:06 INFO - 'install', 14:31:06 INFO - 'run-tests'), 14:31:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:31:06 INFO - 'download_minidump_stackwalk': True, 14:31:06 INFO - 'download_symbols': 'ondemand', 14:31:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:31:06 INFO - 'tooltool.py': '/tools/tooltool.py', 14:31:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:31:06 INFO - '/tools/misc-python/virtualenv.py')}, 14:31:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:31:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:31:06 INFO - 'installer_path': 'installer.exe', 14:31:06 INFO - 'log_level': 'info', 14:31:06 INFO - 'log_name': 'talos', 14:31:06 INFO - 'log_to_console': True, 14:31:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:31:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:31:06 INFO - 'opt_config_files': (), 14:31:06 INFO - 'pip_index': False, 14:31:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:31:06 INFO - 'cmd': ('bash', 14:31:06 INFO - '-c', 14:31:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:31:06 INFO - 'enabled': True, 14:31:06 INFO - 'halt_on_failure': False, 14:31:06 INFO - 'name': 'check_screen_resolution'},), 14:31:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:31:06 INFO - 'cmd': ('bash', 14:31:06 INFO - '-c', 14:31:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:31:06 INFO - 'enabled': True, 14:31:06 INFO - 'halt_on_failure': False, 14:31:06 INFO - 'name': 'check_screen_resolution'},), 14:31:06 INFO - 'run_cmd_checks_enabled': True, 14:31:06 INFO - 'sps_profile': False, 14:31:06 INFO - 'sps_profile_interval': 0, 14:31:06 INFO - 'suite': 'dromaeojs-e10s', 14:31:06 INFO - 'system_bits': '32', 14:31:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:31:06 INFO - 'title': 't-yosemite-r7-0272', 14:31:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:31:06 INFO - 'use_talos_json': True, 14:31:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:31:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:31:06 INFO - 'work_dir': 'build'} 14:31:06 INFO - [mozharness: 2016-08-09 21:31:06.155512Z] Running clobber step. 14:31:06 INFO - Running pre-action listener: _resource_record_pre_action 14:31:06 INFO - Running main action method: clobber 14:31:06 INFO - rmtree: /builds/slave/test/build 14:31:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:31:08 INFO - Running post-action listener: _resource_record_post_action 14:31:08 INFO - [mozharness: 2016-08-09 21:31:08.167349Z] Finished clobber step (success) 14:31:08 INFO - [mozharness: 2016-08-09 21:31:08.167549Z] Running read-buildbot-config step. 14:31:08 INFO - Running pre-action listener: _resource_record_pre_action 14:31:08 INFO - Running main action method: read_buildbot_config 14:31:08 INFO - Using buildbot properties: 14:31:08 INFO - { 14:31:08 INFO - "project": "", 14:31:08 INFO - "product": "firefox", 14:31:08 INFO - "script_repo_revision": "production", 14:31:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:31:08 INFO - "repository": "", 14:31:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:31:08 INFO - "buildid": "20160809121845", 14:31:08 INFO - "pgo_build": "False", 14:31:08 INFO - "basedir": "/builds/slave/test", 14:31:08 INFO - "buildnumber": 73, 14:31:08 INFO - "slavename": "t-yosemite-r7-0272", 14:31:08 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:31:08 INFO - "platform": "yosemite_r7", 14:31:08 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 14:31:08 INFO - "branch": "fx-team", 14:31:08 INFO - "repo_path": "integration/fx-team", 14:31:08 INFO - "revision": "6290767b211dc902629c99ac08be894b1c63d765", 14:31:08 INFO - "stage_platform": "macosx64", 14:31:08 INFO - "builduid": "e9b42fe03e2b447294d1ce3ae51e171c", 14:31:08 INFO - "slavebuilddir": "test" 14:31:08 INFO - } 14:31:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:31:08 INFO - Running post-action listener: _resource_record_post_action 14:31:08 INFO - [mozharness: 2016-08-09 21:31:08.171006Z] Finished read-buildbot-config step (success) 14:31:08 INFO - [mozharness: 2016-08-09 21:31:08.171144Z] Running download-and-extract step. 14:31:08 INFO - Running pre-action listener: _resource_record_pre_action 14:31:08 INFO - Running main action method: download_and_extract 14:31:08 INFO - mkdir: /builds/slave/test/build/tests 14:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:08 INFO - trying https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:31:08 INFO - Downloading https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:31:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 14:31:09 INFO - Downloaded 1199 bytes. 14:31:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:31:09 INFO - Using the following test package requirements: 14:31:09 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:31:09 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:31:09 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:31:09 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:31:09 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:31:09 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:31:09 INFO - u'jsshell-mac.zip'], 14:31:09 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:31:09 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:31:09 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:31:09 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:31:09 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:31:09 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:31:09 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:31:09 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:31:09 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:31:09 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:31:09 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:31:09 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:09 INFO - trying https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:31:09 INFO - Downloading https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:31:10 INFO - Downloaded 16326008 bytes. 14:31:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:31:13 INFO - Return code: 0 14:31:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:13 INFO - trying https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:31:13 INFO - Downloading https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:31:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:31:14 INFO - Downloaded 16326008 bytes. 14:31:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:31:17 INFO - Return code: 0 14:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:17 INFO - trying https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:31:17 INFO - Downloading https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:31:18 INFO - Downloaded 14413723 bytes. 14:31:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:31:19 INFO - Return code: 0 14:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:19 INFO - trying https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:31:19 INFO - Downloading https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 14:31:21 INFO - Downloaded 110876220 bytes. 14:31:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:31:21 INFO - mkdir: /builds/slave/test/properties 14:31:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:21 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:21 INFO - Contents: 14:31:21 INFO - build_url:https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:31:22 INFO - Running post-action listener: _resource_record_post_action 14:31:22 INFO - Running post-action listener: set_extra_try_arguments 14:31:22 INFO - [mozharness: 2016-08-09 21:31:22.593647Z] Finished download-and-extract step (success) 14:31:22 INFO - [mozharness: 2016-08-09 21:31:22.593788Z] Running populate-webroot step. 14:31:22 INFO - Running pre-action listener: _resource_record_pre_action 14:31:22 INFO - Running main action method: populate_webroot 14:31:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:31:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:31:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:31:22 INFO - '--tppagecycles', 14:31:22 INFO - '7'], 14:31:22 INFO - 'tests': ['tsvgm']}}, 14:31:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:31:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:31:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:31:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:31:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:22 INFO - 'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:22 INFO - 'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['damp', 'tps']}, 14:31:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:22 INFO - 'tests': ['damp', 'tps']}, 14:31:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['dromaeo_dom']}, 14:31:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:31:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['basic_compositor_video']}, 14:31:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:31:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['a11yr', 14:31:22 INFO - 'ts_paint', 14:31:22 INFO - 'tpaint', 14:31:22 INFO - 'sessionrestore', 14:31:22 INFO - 'sessionrestore_no_auto_restore', 14:31:22 INFO - 'tabpaint']}, 14:31:22 INFO - 'other-e10s': {'tests': ['a11yr', 14:31:22 INFO - 'ts_paint', 14:31:22 INFO - 'tpaint', 14:31:22 INFO - 'sessionrestore', 14:31:22 INFO - 'sessionrestore_no_auto_restore', 14:31:22 INFO - 'tabpaint']}, 14:31:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:31:22 INFO - 'ts_paint', 14:31:22 INFO - 'tpaint', 14:31:22 INFO - 'sessionrestore', 14:31:22 INFO - 'sessionrestore_no_auto_restore', 14:31:22 INFO - 'tabpaint']}, 14:31:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:31:22 INFO - 'ts_paint', 14:31:22 INFO - 'tpaint', 14:31:22 INFO - 'sessionrestore', 14:31:22 INFO - 'sessionrestore_no_auto_restore', 14:31:22 INFO - 'tabpaint']}, 14:31:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['a11yr', 14:31:22 INFO - 'ts_paint', 14:31:22 INFO - 'tpaint', 14:31:22 INFO - 'sessionrestore', 14:31:22 INFO - 'sessionrestore_no_auto_restore', 14:31:22 INFO - 'tabpaint']}, 14:31:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['a11yr', 14:31:22 INFO - 'ts_paint', 14:31:22 INFO - 'tpaint', 14:31:22 INFO - 'sessionrestore', 14:31:22 INFO - 'sessionrestore_no_auto_restore', 14:31:22 INFO - 'tabpaint']}, 14:31:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['tsvgx', 14:31:22 INFO - 'tsvgr_opacity', 14:31:22 INFO - 'tart', 14:31:22 INFO - 'tscrollx', 14:31:22 INFO - 'cart']}, 14:31:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:31:22 INFO - 'tsvgr_opacity', 14:31:22 INFO - 'tart', 14:31:22 INFO - 'tscrollx', 14:31:22 INFO - 'cart']}, 14:31:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:22 INFO - 'talos_options': ['--disable-e10s'], 14:31:22 INFO - 'tests': ['tp5o']}, 14:31:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:22 INFO - 'tests': ['tp5o']}, 14:31:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:22 INFO - 'talos_options': ['--disable-e10s', 14:31:22 INFO - '--xperf_path', 14:31:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:22 INFO - 'tests': ['tp5n']}, 14:31:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:22 INFO - 'talos_options': ['--xperf_path', 14:31:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:22 INFO - 'tests': ['tp5n']}}, 14:31:22 INFO - 'talos.zip': {'path': '', 14:31:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:31:22 INFO - Running post-action listener: _resource_record_post_action 14:31:22 INFO - [mozharness: 2016-08-09 21:31:22.612982Z] Finished populate-webroot step (success) 14:31:22 INFO - [mozharness: 2016-08-09 21:31:22.613114Z] Running create-virtualenv step. 14:31:22 INFO - Running pre-action listener: _resource_record_pre_action 14:31:22 INFO - Running main action method: create_virtualenv 14:31:22 INFO - Creating virtualenv /builds/slave/test/build/venv 14:31:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:31:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:31:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:31:22 INFO - Using real prefix '/tools/python27' 14:31:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:31:23 INFO - Installing distribute.............................................................................................................................................................................................done. 14:31:26 INFO - Installing pip.................done. 14:31:26 INFO - Return code: 0 14:31:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10346ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103500618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83db563410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, '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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:26 INFO - 'HOME': '/Users/cltbld', 14:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:26 INFO - 'LOGNAME': 'cltbld', 14:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:26 INFO - 'MOZ_NO_REMOTE': '1', 14:31:26 INFO - 'NO_EM_RESTART': '1', 14:31:26 INFO - 'PAGER': '/bin/cat', 14:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:26 INFO - 'PWD': '/builds/slave/test', 14:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:26 INFO - 'SHELL': '/bin/bash', 14:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:31:26 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:26 INFO - 'USER': 'cltbld', 14:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:26 INFO - 'XPC_FLAGS': '0x0', 14:31:26 INFO - 'XPC_SERVICE_NAME': '0', 14:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:31:26 INFO - Cleaning up... 14:31:26 INFO - Return code: 0 14:31:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10346ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103500618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83db563410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, '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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:26 INFO - 'HOME': '/Users/cltbld', 14:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:26 INFO - 'LOGNAME': 'cltbld', 14:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:26 INFO - 'MOZ_NO_REMOTE': '1', 14:31:26 INFO - 'NO_EM_RESTART': '1', 14:31:26 INFO - 'PAGER': '/bin/cat', 14:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:26 INFO - 'PWD': '/builds/slave/test', 14:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:26 INFO - 'SHELL': '/bin/bash', 14:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:31:26 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:26 INFO - 'USER': 'cltbld', 14:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:26 INFO - 'XPC_FLAGS': '0x0', 14:31:26 INFO - 'XPC_SERVICE_NAME': '0', 14:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:26 INFO - Downloading/unpacking psutil>=3.1.1 14:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:31:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:29 INFO - Installing collected packages: psutil 14:31:29 INFO - Running setup.py install for psutil 14:31:29 INFO - building 'psutil._psutil_osx' extension 14:31:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:31:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:31:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:31:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:31:30 INFO - building 'psutil._psutil_posix' extension 14:31:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:31:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:31:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:31:30 INFO - ^ 14:31:30 INFO - 1 warning generated. 14:31:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:31:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:30 INFO - Successfully installed psutil 14:31:30 INFO - Cleaning up... 14:31:31 INFO - Return code: 0 14:31:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:31 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 0x10346ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103500618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83db563410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, '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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:31 INFO - 'HOME': '/Users/cltbld', 14:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:31 INFO - 'LOGNAME': 'cltbld', 14:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:31 INFO - 'MOZ_NO_REMOTE': '1', 14:31:31 INFO - 'NO_EM_RESTART': '1', 14:31:31 INFO - 'PAGER': '/bin/cat', 14:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:31 INFO - 'PWD': '/builds/slave/test', 14:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:31 INFO - 'SHELL': '/bin/bash', 14:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:31:31 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:31 INFO - 'USER': 'cltbld', 14:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:31 INFO - 'XPC_FLAGS': '0x0', 14:31:31 INFO - 'XPC_SERVICE_NAME': '0', 14:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:31:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:31:33 INFO - Installing collected packages: mozsystemmonitor 14:31:33 INFO - Running setup.py install for mozsystemmonitor 14:31:34 INFO - Successfully installed mozsystemmonitor 14:31:34 INFO - Cleaning up... 14:31:34 INFO - Return code: 0 14:31:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:34 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 0x10346ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103500618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83db563410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, '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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:31:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:31:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:34 INFO - 'HOME': '/Users/cltbld', 14:31:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:34 INFO - 'LOGNAME': 'cltbld', 14:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:34 INFO - 'MOZ_NO_REMOTE': '1', 14:31:34 INFO - 'NO_EM_RESTART': '1', 14:31:34 INFO - 'PAGER': '/bin/cat', 14:31:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:34 INFO - 'PWD': '/builds/slave/test', 14:31:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:34 INFO - 'SHELL': '/bin/bash', 14:31:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:31:34 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:31:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:34 INFO - 'USER': 'cltbld', 14:31:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:34 INFO - 'XPC_FLAGS': '0x0', 14:31:34 INFO - 'XPC_SERVICE_NAME': '0', 14:31:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:34 INFO - Downloading/unpacking jsonschema==2.5.1 14:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:31:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:37 INFO - Downloading functools32-3.2.3-2.tar.gz 14:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:31:37 INFO - warning: no files found matching '*.txt' 14:31:37 INFO - no previously-included directories found matching 'build' 14:31:37 INFO - no previously-included directories found matching 'dist' 14:31:37 INFO - no previously-included directories found matching '.git*' 14:31:37 INFO - Installing collected packages: jsonschema, functools32 14:31:37 INFO - Running setup.py install for functools32 14:31:37 INFO - warning: no files found matching '*.txt' 14:31:37 INFO - no previously-included directories found matching 'build' 14:31:37 INFO - no previously-included directories found matching 'dist' 14:31:37 INFO - no previously-included directories found matching '.git*' 14:31:37 INFO - Successfully installed jsonschema functools32 14:31:37 INFO - Cleaning up... 14:31:37 INFO - Return code: 0 14:31:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10346ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103500618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83db563410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, '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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:37 INFO - 'HOME': '/Users/cltbld', 14:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:37 INFO - 'LOGNAME': 'cltbld', 14:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:37 INFO - 'MOZ_NO_REMOTE': '1', 14:31:37 INFO - 'NO_EM_RESTART': '1', 14:31:37 INFO - 'PAGER': '/bin/cat', 14:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:37 INFO - 'PWD': '/builds/slave/test', 14:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:37 INFO - 'SHELL': '/bin/bash', 14:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:31:37 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:37 INFO - 'USER': 'cltbld', 14:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:37 INFO - 'XPC_FLAGS': '0x0', 14:31:37 INFO - 'XPC_SERVICE_NAME': '0', 14:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:31:37 INFO - Cleaning up... 14:31:37 INFO - Return code: 0 14:31:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:37 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 0x10346ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103500618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83db563410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, '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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:37 INFO - 'HOME': '/Users/cltbld', 14:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:37 INFO - 'LOGNAME': 'cltbld', 14:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:37 INFO - 'MOZ_NO_REMOTE': '1', 14:31:37 INFO - 'NO_EM_RESTART': '1', 14:31:37 INFO - 'PAGER': '/bin/cat', 14:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:37 INFO - 'PWD': '/builds/slave/test', 14:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:37 INFO - 'SHELL': '/bin/bash', 14:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:31:37 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:37 INFO - 'USER': 'cltbld', 14:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:37 INFO - 'XPC_FLAGS': '0x0', 14:31:37 INFO - 'XPC_SERVICE_NAME': '0', 14:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:38 INFO - Downloading/unpacking blobuploader==1.2.4 14:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:40 INFO - Downloading blobuploader-1.2.4.tar.gz 14:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:31:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:31:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:41 INFO - Downloading docopt-0.6.1.tar.gz 14:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:31:41 INFO - Installing collected packages: blobuploader, requests, docopt 14:31:41 INFO - Running setup.py install for blobuploader 14:31:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:31:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:31:42 INFO - Running setup.py install for requests 14:31:42 INFO - Running setup.py install for docopt 14:31:42 INFO - Successfully installed blobuploader requests docopt 14:31:42 INFO - Cleaning up... 14:31:42 INFO - Return code: 0 14:31:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:42 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 0x10346ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103500618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83db563410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, '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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:31:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:42 INFO - 'HOME': '/Users/cltbld', 14:31:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:42 INFO - 'LOGNAME': 'cltbld', 14:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:42 INFO - 'MOZ_NO_REMOTE': '1', 14:31:42 INFO - 'NO_EM_RESTART': '1', 14:31:42 INFO - 'PAGER': '/bin/cat', 14:31:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:42 INFO - 'PWD': '/builds/slave/test', 14:31:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:42 INFO - 'SHELL': '/bin/bash', 14:31:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:31:42 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:31:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:42 INFO - 'USER': 'cltbld', 14:31:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:42 INFO - 'XPC_FLAGS': '0x0', 14:31:42 INFO - 'XPC_SERVICE_NAME': '0', 14:31:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:43 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-NkX77Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:43 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-Q4XC3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:43 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-EQcXOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:43 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-oXHM2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:43 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-hNKenY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:43 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-zgAsWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:43 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-k8onk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:43 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-JGwb4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:43 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-PLk91v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-f_OFSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-mUKS3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-cy6lLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-ugZU4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-TkZOx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-9qjXRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-GRqzRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:44 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-qBLkRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:31:44 INFO - Running setup.py install for manifestparser 14:31:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:31:45 INFO - Running setup.py install for mozcrash 14:31:45 INFO - Running setup.py install for mozdebug 14:31:45 INFO - Running setup.py install for mozdevice 14:31:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:31:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:31:45 INFO - Running setup.py install for mozfile 14:31:45 INFO - Running setup.py install for mozhttpd 14:31:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:31:45 INFO - Running setup.py install for mozinfo 14:31:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:31:45 INFO - Running setup.py install for mozInstall 14:31:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Running setup.py install for mozleak 14:31:46 INFO - Running setup.py install for mozlog 14:31:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Running setup.py install for moznetwork 14:31:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Running setup.py install for mozprocess 14:31:46 INFO - Running setup.py install for mozprofile 14:31:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Running setup.py install for mozrunner 14:31:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:31:47 INFO - Running setup.py install for mozscreenshot 14:31:47 INFO - Running setup.py install for moztest 14:31:47 INFO - Running setup.py install for mozversion 14:31:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:31:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:31:47 INFO - Cleaning up... 14:31:47 INFO - Return code: 0 14:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:47 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 0x10346ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103500618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83db563410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, '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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:31:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:47 INFO - 'HOME': '/Users/cltbld', 14:31:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:47 INFO - 'LOGNAME': 'cltbld', 14:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:47 INFO - 'MOZ_NO_REMOTE': '1', 14:31:47 INFO - 'NO_EM_RESTART': '1', 14:31:47 INFO - 'PAGER': '/bin/cat', 14:31:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:47 INFO - 'PWD': '/builds/slave/test', 14:31:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:47 INFO - 'SHELL': '/bin/bash', 14:31:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:31:47 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:31:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:47 INFO - 'USER': 'cltbld', 14:31:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:47 INFO - 'XPC_FLAGS': '0x0', 14:31:47 INFO - 'XPC_SERVICE_NAME': '0', 14:31:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:47 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-XKQSv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:47 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-fsx7oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:48 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-ckz059-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:48 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-327EF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:48 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-F92_IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:48 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-JenrsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:48 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-pmd5XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:48 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-ohUPJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:48 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-6tJUEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:48 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-OxHgCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:48 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-KVYGf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:48 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-AtjiKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:49 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-7Yh250-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:49 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-xe0ZRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:49 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-oxaxsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:49 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-qTFKwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:49 INFO - Running setup.py (path:/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/pip-0dGGSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:51 INFO - Downloading blessings-1.6.tar.gz 14:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:31:52 INFO - Installing collected packages: blessings 14:31:52 INFO - Running setup.py install for blessings 14:31:52 INFO - Successfully installed blessings 14:31:52 INFO - Cleaning up... 14:31:52 INFO - Return code: 0 14:31:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:31:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:52 INFO - Reading from file tmpfile_stdout 14:31:52 INFO - Current package versions: 14:31:52 INFO - blessings == 1.6 14:31:52 INFO - blobuploader == 1.2.4 14:31:52 INFO - docopt == 0.6.1 14:31:52 INFO - functools32 == 3.2.3-2 14:31:52 INFO - jsonschema == 2.5.1 14:31:52 INFO - manifestparser == 1.1 14:31:52 INFO - mozInstall == 1.12 14:31:52 INFO - mozcrash == 0.17 14:31:52 INFO - mozdebug == 0.1 14:31:52 INFO - mozdevice == 0.48 14:31:52 INFO - mozfile == 1.2 14:31:52 INFO - mozhttpd == 0.7 14:31:52 INFO - mozinfo == 0.9 14:31:52 INFO - mozleak == 0.1 14:31:52 INFO - mozlog == 3.3 14:31:52 INFO - moznetwork == 0.27 14:31:52 INFO - mozprocess == 0.23 14:31:52 INFO - mozprofile == 0.28 14:31:52 INFO - mozrunner == 6.12 14:31:52 INFO - mozscreenshot == 0.1 14:31:52 INFO - mozsystemmonitor == 0.3 14:31:52 INFO - moztest == 0.7 14:31:52 INFO - mozversion == 1.4 14:31:52 INFO - psutil == 3.1.1 14:31:52 INFO - requests == 1.2.3 14:31:52 INFO - wsgiref == 0.1.2 14:31:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:52 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 0x10346ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103500618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83db563410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, '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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:31:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:52 INFO - 'HOME': '/Users/cltbld', 14:31:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:52 INFO - 'LOGNAME': 'cltbld', 14:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:52 INFO - 'MOZ_NO_REMOTE': '1', 14:31:52 INFO - 'NO_EM_RESTART': '1', 14:31:52 INFO - 'PAGER': '/bin/cat', 14:31:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:52 INFO - 'PWD': '/builds/slave/test', 14:31:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:52 INFO - 'SHELL': '/bin/bash', 14:31:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:31:52 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:31:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:52 INFO - 'USER': 'cltbld', 14:31:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:52 INFO - 'XPC_FLAGS': '0x0', 14:31:52 INFO - 'XPC_SERVICE_NAME': '0', 14:31:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:31:52 INFO - Cleaning up... 14:31:52 INFO - Return code: 0 14:31:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:52 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 0x10346ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103500618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83db563410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, '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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:31:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:31:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:52 INFO - 'HOME': '/Users/cltbld', 14:31:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:52 INFO - 'LOGNAME': 'cltbld', 14:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:52 INFO - 'MOZ_NO_REMOTE': '1', 14:31:52 INFO - 'NO_EM_RESTART': '1', 14:31:52 INFO - 'PAGER': '/bin/cat', 14:31:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:52 INFO - 'PWD': '/builds/slave/test', 14:31:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:52 INFO - 'SHELL': '/bin/bash', 14:31:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:31:52 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:31:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:52 INFO - 'USER': 'cltbld', 14:31:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:52 INFO - 'XPC_FLAGS': '0x0', 14:31:52 INFO - 'XPC_SERVICE_NAME': '0', 14:31:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:31:53 INFO - Cleaning up... 14:31:53 INFO - Return code: 0 14:31:53 INFO - Running post-action listener: _resource_record_post_action 14:31:53 INFO - Running post-action listener: _start_resource_monitoring 14:31:53 INFO - Starting resource monitoring. 14:31:53 INFO - [mozharness: 2016-08-09 21:31:53.178139Z] Finished create-virtualenv step (success) 14:31:53 INFO - [mozharness: 2016-08-09 21:31:53.179162Z] Running install step. 14:31:53 INFO - Running pre-action listener: _resource_record_pre_action 14:31:53 INFO - Running main action method: install 14:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:53 INFO - Reading from file tmpfile_stdout 14:31:53 INFO - Detecting whether we're running mozinstall >=1.0... 14:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:31:53 INFO - Reading from file tmpfile_stdout 14:31:53 INFO - Output received: 14:31:53 INFO - Usage: mozinstall [options] installer 14:31:53 INFO - Options: 14:31:53 INFO - -h, --help show this help message and exit 14:31:53 INFO - -d DEST, --destination=DEST 14:31:53 INFO - Directory to install application into. [default: 14:31:53 INFO - "/builds/slave/test"] 14:31:53 INFO - --app=APP Application being installed. [default: firefox] 14:31:53 INFO - mkdir: /builds/slave/test/build/application 14:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:32:28 INFO - Reading from file tmpfile_stdout 14:32:28 INFO - Output received: 14:32:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:32:28 INFO - Running post-action listener: _resource_record_post_action 14:32:28 INFO - [mozharness: 2016-08-09 21:32:28.114904Z] Finished install step (success) 14:32:28 INFO - [mozharness: 2016-08-09 21:32:28.115073Z] Running run-tests step. 14:32:28 INFO - Running pre-action listener: _resource_record_pre_action 14:32:28 INFO - Running main action method: run_tests 14:32:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:32:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:32:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:32:28 INFO - 2016-08-09 14:32:28.129 screenresolution[1638:7353] starting screenresolution argv=screenresolution get 14:32:28 INFO - 2016-08-09 14:32:28.132 screenresolution[1638:7353] Display 0: 1600x1200x32@60 14:32:28 INFO - 2016-08-09 14:32:28.138 screenresolution[1639:7355] starting screenresolution argv=screenresolution list 14:32:28 INFO - Available Modes on Display 0 14:32:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:32:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:32:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:32:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:32:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:32:28 INFO - Intel Iris: 14:32:28 INFO - Chipset Model: Intel Iris 14:32:28 INFO - Type: GPU 14:32:28 INFO - Bus: Built-In 14:32:28 INFO - VRAM (Dynamic, Max): 1536 MB 14:32:28 INFO - Vendor: Intel (0x8086) 14:32:28 INFO - Device ID: 0x0a2e 14:32:28 INFO - Revision ID: 0x0009 14:32:28 INFO - Displays: 14:32:28 INFO - Display: 14:32:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:32:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:32:28 INFO - Display Serial Number: 1600x1200 60 14:32:28 INFO - Main Display: Yes 14:32:28 INFO - Mirror: Off 14:32:28 INFO - Online: Yes 14:32:28 INFO - Rotation: Supported 14:32:28 INFO - Return code: 0 14:32:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:32:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:32:28 INFO - Python 2.7.3 14:32:28 INFO - Return code: 0 14:32:28 INFO - grabbing minidump binary from tooltool 14:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:28 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 0x1033cfd30>, '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 0x103134db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033c7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:32:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:32:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:32:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:32:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:32:28 INFO - Return code: 0 14:32:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:32:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:32:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:32:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:32:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:32:28 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/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0272', '--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 14:32:28 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/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0272 --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 14:32:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qLfn2N4aMy/Render', 14:32:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:28 INFO - 'HOME': '/Users/cltbld', 14:32:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:28 INFO - 'LOGNAME': 'cltbld', 14:32:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:32:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:28 INFO - 'MOZ_NO_REMOTE': '1', 14:32:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:32:28 INFO - 'NO_EM_RESTART': '1', 14:32:28 INFO - 'PAGER': '/bin/cat', 14:32:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:28 INFO - 'PWD': '/builds/slave/test', 14:32:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:32:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:28 INFO - 'SHELL': '/bin/bash', 14:32:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9XCK4s4qQG/Listeners', 14:32:28 INFO - 'TMPDIR': '/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/', 14:32:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:28 INFO - 'USER': 'cltbld', 14:32:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:28 INFO - 'XPC_FLAGS': '0x0', 14:32:28 INFO - 'XPC_SERVICE_NAME': '0', 14:32:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:28 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/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0272', '--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 14:32:28 INFO - mozversion application_buildid: 20160809121845 14:32:28 INFO - mozversion application_changeset: 6290767b211dc902629c99ac08be894b1c63d765 14:32:28 INFO - mozversion application_display_name: Nightly 14:32:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:32:28 INFO - mozversion application_name: Firefox 14:32:28 INFO - mozversion application_remotingname: firefox 14:32:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:32:28 INFO - mozversion application_vendor: Mozilla 14:32:28 INFO - mozversion application_version: 51.0a1 14:32:28 INFO - mozversion platform_buildid: 20160809121845 14:32:28 INFO - mozversion platform_changeset: 6290767b211dc902629c99ac08be894b1c63d765 14:32:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:32:28 INFO - mozversion platform_version: 51.0a1 14:32:28 INFO - using testdate: 1470778348 14:32:28 INFO - actual date: 1470778348 14:32:28 INFO - starting webserver on 'localhost:49266' 14:32:28 INFO - SUITE-START | Running 2 tests 14:32:28 INFO - TEST-START | dromaeo_css 14:32:28 INFO - operating with platform_type : mac_ 14:32:28 INFO - Initialising browser for dromaeo_css test... 14:32:28 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpZ2T2Tp/profile http://localhost:49266/getInfo.html) 14:32:31 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 14:32:31 INFO - PROCESS | 1649 | colorDepth:24 14:32:31 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 14:32:31 INFO - PROCESS | 1649 | __metrics 14:32:31 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:32:32 INFO - TEST-INFO | 1649: exit 0 14:32:32 INFO - Browser initialized. 14:32:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:32:32 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpZ2T2Tp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:44 INFO - PROCESS | 1652 | RSS: Main: 254926848 14:32:44 INFO - PROCESS | 1652 | 14:33:34 INFO - PROCESS | 1652 | 1470778414004 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:35:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 14:35:48 INFO - PROCESS | 1652 | RSS: Main: 267423744 14:35:48 INFO - PROCESS | 1652 | 14:38:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 14:38:51 INFO - PROCESS | 1652 | RSS: Main: 280186880 14:38:51 INFO - PROCESS | 1652 | 14:41:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 14:41:53 INFO - PROCESS | 1652 | RSS: Main: 287424512 14:41:53 INFO - PROCESS | 1652 | 14:44:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 14:44:56 INFO - PROCESS | 1652 | RSS: Main: 286257152 14:44:56 INFO - PROCESS | 1652 | 14:47:58 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 14:47:59 INFO - PROCESS | 1652 | RSS: Main: 291528704 14:47:59 INFO - PROCESS | 1652 | 14:51:02 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 14:51:02 INFO - PROCESS | 1652 | RSS: Main: 291209216 14:51:02 INFO - PROCESS | 1652 | 14:51:02 INFO - PROCESS | 1652 | __start_tp_report 14:51:02 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 14:51:02 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 14:51:02 INFO - PROCESS | 1652 | |i|pagename|runs| 14:51:02 INFO - PROCESS | 1652 | |0;dojo.html;3420.4527275635887;3457.5332330135434;3466.462698281767;3478.3043391321735;3483.512308276843;5661.23573317603;5902.2622172228475;5910.586258961875;5915.911261331084;5964.910526342108;4814.9037019259595;5874.970625146868;5884.970575147118;5908.231929849125;5997.970010149943;5245.108331583621;5298.973505132488;5340.25236466895;5434.076207044792;5447.591430642698;5390.78436862527;5402.540784033362;5446;5461.2354270402175;5512.6692398456225;5203.60972927032;5237.47625237477;5271.051210782058;5310.62825602208;5354.3574771027725;5271.815486457994;5275.86810329741;5295.073362161645;5337.039332920072;5350.946490535122;5048.6465947383695;5288.497592728685;5294.1529355303355;5344.358676958751;5359.651622644516;5722.456366645162;5783.334916484616;5923.111533270001;5938.168656388066;5946.940530594682;6154.44609985099;6164.476019538344;6172.8765424691255;6215.875682486325;6223.408776166257;6237.095621134956;6260.499160067184;6266.248050234001;6267.62394256346;6278.30938596754;5827.592068555203;5915.290165180163;5979.133025711334;6006.609570377911;6059.515238780887;6325.683715814191;6356.427921486996;6367.936320636827;6373.904391434132;6419.679016049179;6139.539534534928;6176.227971503562;6184.5980011299125;6200.782972596027;6203.286622038433;6112.381899552462;6117.9187529241;6165.8458538536;6172.197614310201;6185.907211391833;6123.862238009563;6142.1304578115505;6165.876682466325;6185;6203.410675985774;5322.733863306897;5980.491658209014;6119.143319935212;6230.158928544589;6280.649660323053;4763.785629646674;4902.754862256873;4957.752112394366;4984.77568509418;4995.675281106716;4463.218936686067;4510.345999830006;4527.253003254426;4550.13547425988;4567.588916997486;5822.912656310159;5908.645481271137;5913.319968203626;5923.792667256712;5931.73307201177;5112.565431938327;6199.845003874939;6208.565400421927;6240.937590624036;6246.718897649616;5942.58401911862;5942.613730107616;5952;5993.940060599425;6005;5498.890022199534;5506.1190209566275;5511.338639363222;5518.972405137949;5541.695206763586;6217.658028808278;6261.812145635638;6266.185395898504;6398.232212134573;6488.383603557749;6200.348963358782;6231.096491008869;6233.906491402723;6236.345183755821;6274.905876411949;6314.400131987454;6366.554341196072;6373.936260637334;6378.840528986812;6523.739050437929;6131.601445906002;6164.982777841606;6181.567290289637;6284.277308109443;6293.842653933688;6156.569040167145;6214.067889816563;6225.3774622537385;6225.595336303126;6228.22147231596;6088.6042407243385;6168.845778855564;6238.500919926486;6245.0632405139595;6246.750129994931;6090.269167699905;6141.884937092248;6153.907691384543;6247.562670613195;6263.185785847811;6010.068439391901;6090.878182436415;6110.205673262448;6114.847128821637;6139.416755408229;6192.690365481798;6201.473173598497;6214;6216.129741836237;6279.780207692709;5907.3797251288;6092.969535152296;6110.633361998294;6137.907931380943;6162.476189523762 14:51:02 INFO - PROCESS | 1652 | |1;ext.html;467.41573033707886;471.96460265480084;486.56452475034854;537.2049366936933;570.9800156994506;31472.68527314726;41441.75674729756;41547.169056618884;41589.58410415899;41689.7915510422;42220.36669449961;42812.571874281246;42846.357304640456;42963.57036429635;43141.56858431415;8580.056193818675;9588.856167157515;9767.267454940873;9791.755206119868;9803.460809655466;9588.90411095887;9725.319227654067;9736.805263894717;9771.071748183911;9776.90223097767;9758.560864761068;9761.267904907125;9774.853377199348;9777;9801.509924503782;9723.756906077333;9742.366746161477;9767.462789546573;9780.90219097807;9784.266180036526;9639.325247232697;9728.951355243178;9730;9748.902510974942;9755.36590121647;40395.39406908899;40643.18713625711;40734.79632601848;40910.1817963642;40985.1802963942;3084.36770462057;3359.5800524934384;3485.8082805445692;3500.474928760681;3562.4834399011997;29611.259718506994;31223.843880780678;31951.6804831951;32029;32125.839370802998;3042.1938186380626;3176.872925082994;3183.1564635371647;3196.9360612787846;3210.7431405487505;503746;515455;520483;522289;522919.9999999962;54906;58057;64717.35282647207;65289.694206115615;65576.34423655702;29480.852595737313;36153.45769813402;36216;57040;68274.46569178853;14487.710245795026;16835.24241409115;16898.74651880223;17026.489205323862;17086.572835679206;11060.281081729661;12876.613701588967;12931.612051638465;12995.740085198433;13029.957603391895;19988.20047198096;20237.392878213675;20290.79709202889;20318.898405507876;20332.491687707927;7220.9638951805955;8069.556174410463;8081.393895457864;8166.632501537326;8170.918290817134;879.4107947675074;967.5404183013012;1030.4178139351243;1038.8441733739999;1047.6542740895486;31088;31187.376252474824;31193.68806311953;31455.685443145274;32457;1024.6823484719762;1036.4972988100765;1066.6000249906285;1116.190761697779;1134.5575225661833;16129.838701612834;16149.354025838835;16305.836941630669;16563.42028029013;16563.91718041402;782945;785979;982632;998647.0067649761;1000226;60712.69643651754;61255.693721531105;63902.680486597266;64273.67863160654;64403.67798160979;1378.827646544182;1391.923444210578;1402.7194561088027;1403.677154254527;1416.3484796993498;31308.373832522768;32026.679733203302;32247.677523225408;32769.836150819094;32782.67217327796;55042.34872953818;55104.448955509935;55523.61190970258;55632;55733.721331393084;608142;608888;614140;615799;616622.9168854126;44991;45732.54267457416;46247;46431;46493.53506464892;49569.25646115383;50317.49682503128;50801.49198508116;51116.97766044733;51766.482335176166;37262.62737372592;40671.59328406678;40931;41253.79373103115;42597.57402425936;39386;40407.79796101001;40787.38818917659;41046.58953410428;41992.79003604963;33570.82502112415;39032;39930;39951.60048399595;39959;31453;33375;36073.63926360703;36529.81735091307;36724.44913326249;22610.773892260866;22734.886325568266;26106.955721770915;26466.206013819618;27029.1891243263 14:51:02 INFO - PROCESS | 1652 | |2;jquery.html;342;344.5796128722958;358.8528703231674;381.3402813133279;387.66854339539674;20054.089452556756;20137.697934530974;21226;21488.462788430297;21585.704857708548;16360.754588681179;20521.17915283387;21309.57380852382;21319;21339.146434142614;5183.585313174955;5937.287525496947;6016.548758843082;6049.637021778685;6161.19904412428;5126.666766660173;5827.300723913137;5982.581219314649;6031.849203769897;6096.542759293071;5892.440218179266;5914.172015917775;5967.462928336449;5989.221401217836;6013.1882195903645;5893.79371721992;5942.732577034044;5948.643081415107;5964.1650168976375;5966.389074949782;5061.519155680205;5192.584593232532;5353.170258609922;5396.406395296514;5396.973015134939;14217.21805300708;24887.751122488724;25429.364265893317;25435.872820635963;25574;2078.5842831433774;2438.0491608272787;2846.6868644449096;2913.6212292402065;2953.689862564421;8583.95708021462;10282.640107596199;12637.49450021998;14062;15105.54683359501;1544.7564710408117;1853.1197681101503;1857.4149143019906;1870.3827736846808;1908.4942490240098;114321;119362;121108;123013.38493307476;125547;11182.888171118184;11341.26281791681;11558.884411155948;11611.535538578362;11761.471008768805;14342.928285358506;14396.568102956928;14397.280135993158;14398.496052638317;14444;8304.6678132874;8585.570721464026;8597.957010215034;8689.869651955225;8726.04013558508;8524.14758524155;8525.31797456202;8534.74395768128;8588.785280368042;8723.956380218186;4454.844080457168;4534.682572219979;4536.138133754576;4567.177907976529;4604.1252162089095;1912.6461604602914;1927.7012063130237;1933.8162874526897;1968.773591037049;1975.5950030243766;812.8943237379103;869.860822268434;875.695214130953;904.7285814255697;945.8912225094065;17887.821121788875;20930.37208883736;21294.78705212959;21396;21500.92495375225;811.8863359129726;893.4594570285014;938.6949241496541;947.8293907096651;1073.742301847551;9503.239740820718;10654.62708805188;11495.482703278372;11496.885031149748;11510.59712910044;521988;522424;523218.76781232463;557433;580158;128550;141457;143868;156380;157182.42817571908;991.2367477042637;1023.7389465686202;1037.025196315461;1038.6364772329623;1040.2977989856815;18736.81263187351;19022.809771902103;19419.126139324046;19531.12109955027;19589;54670.453295466534;55376;58292.708536457045;58622.120668189156;59169;60493.69753151206;73959.63020184865;74530.88203676841;74908.25091749012;86323.70514442414;7894.0132483439575;7981.760547183594;8060.39547033963;8161.877571836309;8197.83604327922;10671.092957098734;11450.198486105892;11681;12671.429785659482;13011.828935395859;9045.95477022637;11013.944930275296;11142.108631309313;11333.943330283295;11514.136439766884;8246.587670616565;10036.899631003596;10566.735831604272;11149.331040137293;11273.887261127611;10589.258751887293;11175.832362514731;11453.48459319316;11459.828102578635;11783.175177737476;7245.637718113968;7900.881486777588;8098.271155596025;8109.27016568488;8273.420860539705;11086.057685096857;11092.168087393638;11120.388378639253;11300.434978251218;11330.773384532098 14:51:02 INFO - PROCESS | 1652 | |3;mootools.html;1345.5963211036687;1505.2398538737937;1721.535185499915;1834.4221570205375;1875.690511065675;7866.213378662131;8262.876056859144;8411.83176336473;8809.942806863177;8826.823463530725;8521.062683104854;8676.566171691422;8690.478571285727;8721.43310684805;8735.606897689604;2296.9540609187848;2345.44881952741;2346;2346.343023953296;2347.260612906929;2289.473421113145;2297.448612333036;2346.4837735698206;2348.9295321140307;2354.482013956935;2339.894704738291;2342.0982921575146;2351.423901144222;2354.517323948595;2358.8348815582917;2295.988520057406;2298.8735619540917;2315.235972129193;2317.0731707316954;2326.1742081561056;1998.2206939293687;2323.488832456857;2327.837051406402;2329.77867102625;2334.3813889319345;8693.7826554336;8712.825743485095;8780.034196238408;8785.692500762507;8786.60460279289;5130.640855140142;5282.498162674539;5315.282436871012;5323.148296272578;5327.866803329948;3443.483477478373;3483.8780642677384;3565.625609311037;3582.444721068239;3637.6180501047274;1060.5015642647943;1082.94953894722;1094.441834664319;1102.2064113838023;1112.7830073135742;11219.943900280528;11294.887051129466;11376.203665743402;11393.943030284878;11407.600733974354;3796.7532110412735;4489.32660100981;4711.293306004059;4714.104320179155;4730.95269047312;9498.287628427895;9851.867035291034;9855.80288394228;9868.901310986941;9882.160016398686;4778.187708089564;5258.447862974333;5272.578193744491;5291.682499049993;5304.177852432879;4366.476022877275;4674.813007479663;4800.591949684246;4820.084184005028;4836.613070954315;3804;3931;3943.940840887389;3950.249452603996;4026.7583944963394;1278.9936050319689;1284.5054653958107;1291.0510774580675;1294.4692676002983;1296.293520031585;927.6150397585062;938.4603852784539;948.8434408322687;959.2901253072815;1007.1087087927237;5812.215350927655;5822.7088645567555;6054.909176362358;6117.663528505975;6130.693465326716;429.5210839913474;430.30290928695086;436.7401396169274;442.4579889635171;444.83096423358916;3963.6432721055244;3990.0024993751563;4026.335654617014;4071.42999980003;4111.835526578903;10182.439965801952;10487.632932847466;10568.735781605368;10629.681109566725;10638.255322127377;10441.947790261;10529.789404211873;10540.9986051325;10556.841647375295;10593.470326483644;8056.758297251092;8154.8776768348525;8161.347092232726;8172.387070969701;8183.71357002502;5549.834534747587;5737.540996720169;5749.223854779719;5912.349641539341;5966.582339236385;9820.950895245478;9868;9907.45508997012;9934.900650993397;9944.801103978025;8513.40406171562;9590.808183836423;10050.447225402673;10090.293679442368;10103.49482525856;6216.347283535345;6813.761518346834;7187.892181617175;7385.926140738524;7460.253974602496;8184.672613095409;8226.712065077694;8298;8324.875126872981;8338.207870252316;7307.561546307238;7355.7057717690695;7399.852002960019;7444.292792184734;7569.318761311288;7107.538010029331;7286.125664920243;7362.705491780269;7413.999110120065;7417.258274172756;6902.551334163464;6918.584884906922;7006.439484841098;7015.6842942066705;7020.438364930691;4956.603471722182;5041.621878359211;5053.166227572409;5063.1898896176435;5132.692038477703;4601.401817763804;4817.8313759018265;5003.3245511856885;5184.559312458483;5185.559227465707 14:51:02 INFO - PROCESS | 1652 | |4;prototype.html;288.77619844620415;306.058868977893;312.67481818908334;313.5798030638944;316.1511342046605;4624.60690841278;5175.844724658257;5607.607467477278;5724.627899186555;5732.054211055176;4467.888302792432;4831.613470922327;4922.43392009919;5654.406287339832;5678.744456499458;4160.7295525790805;4351.303791393378;4365;4365.279728844736;4382.364557139213;4202.327627579588;4304.289792184286;4322.82708691652;4360.672949528782;4388.561143885618;4279.037216626265;4290.721103128287;4294.377315289281;4306.9420711295015;4308.224519586473;3789.8863034108745;4301.526832048487;4318;4318.01371369169;4325.82696692132;3152;3609.3864043112735;3733.328000959826;3734.506197520986;3795.9430608540893;4758.452777930548;5544.306961629796;5573.331200255955;5597.328320601554;5604.915926261109;4214.672378200857;4966.50334966504;5004.324416203803;5015.84952451427;5018.7992480300745;5658.547316214693;6001.909971350433;6025.548083893726;6051.152838602599;6066.393360663942;3463.8268086595567;3648.361536731088;4058.7767672777986;4089.6932730045364;4142.544320124784;5442.6462279951675;6290.43386095249;6306.936930630681;6312.968435157841;6337.87324253517;3798.3732684107367;4043.9283589848715;4166.437530933345;4200.844767688849;4205.201011807747;3659.6157403472785;3968.503937007874;4111.519852852971;4133.545310015896;4146.170765846843;4284.964641795123;4885;4904.730239836843;4922.310876477296;4949.876253093629;5082.390113186368;5139.691618502827;5992.711567013026;5993.400659934059;5999.340072592011;1122.7080958950733;1155.4165146600913;1245.9252444853337;1419.7160567886465;1426.0089237979505;777.941654375924;826.5867066466767;833.98332033359;839.3369238301796;860.242986172177;4367.67242456817;4817.421909370828;4818.759062046884;4832;4885.8045678173185;4818.68678535894;5051.318072060225;5102.923456148161;5186.576859272862;5230.529252367305;4165.250594750212;4293.957060429356;4447.644188464915;4744.905101897943;4825.9758701206265;2464.6937123324665;2595.8442493450452;2773.9057011956247;2780.7497325240824;2788.372616161388;5029.84910452687;5283.735813209324;5390.784368625211;5445.37378201504;5468.7539060742365;4913.484084171182;4945.282933974553;5257.631965762436;5295.346211114319;5383.977044361559;4679.742614156254;4709.3877795887;5030.465707959108;5412.891742165135;5449.727513624303;4618.782984167551;4791.353167322367;4895.902081958412;5162.457941916195;5205.375354957429;4826.541478559531;4944.975275123601;5112.821051263188;5174.844754657366;5185.51095474167;4356.869293921188;5320.334958130234;5380.735527151194;5407.513323800719;5456.863578410413;3275.6724327567053;3569.5894972078545;3846.3461211593535;4013.3578627419474;4031.6573091286396;5162.5095615916425;5619.353774316006;5858;6066.272047354169;6100.054491553817;4924.606031517542;5809.331926828469;5939.584229103922;5945.762169513171;6077.171382029293;4672.962574326715;5862.267216597926;5947.524198064058;6008.309044459943;6040.848978775566;5872;5884.46931840892;5897.115432685132;5921.6743079131065;5924.933511967887;5444.727763611882;5726.282115365457;5744.971275143765;5909.143174239625;6004.459598636144;5402.432744561765;5622.582289615505;5853.9121913172185;5882.117682347511;5895.170318247179 14:51:02 INFO - PROCESS | 1652 | |5;yui.html;713.2368365848541;718.3929579505319;774.0827119862963;780.7735756630577;819.6024927909963;15341.616459588517;15692.215389230521;16064;16217.75673364899;16243.269052892618;14192.645183870409;14515.056521326107;14588.270586470688;14648.26758662068;14660.340284687189;672.7510820996238;840.4663038970267;843.6035063520151;866.9263112635402;868.8696695495695;841.8610929196675;856.8586183279751;857.8498762716531;859.2095272349453;859.995700021499;794.7403365665427;906.9319801014917;915.5239275576696;918.1002617434917;922.1424075609681;774.8062984253936;905.7237542549552;916.8762217100673;916.8945571259324;916.9495677737722;680.0886811672383;681.9488538359593;683.2689022745664;684.4729558240177;684.7842929477199;14880.70238595222;14896.031757935807;14925.92537037308;14950.177740224284;14978.026428282126;14713.852861471463;14715.411383544646;14765.114093154445;14828.258587070603;14884.925575372054;9906.827341287237;12063.698407539794;12243.510259589606;12431.12982091254;12570.748585028248;3897.31796935538;3920.607939206085;3960.7425517341567;4050.797460126982;4051.8379264829373;108152.37771433435;109581;109992.4500377501;110034.44982775114;118263;9532.380395274286;11274.041706455044;11337.773244535229;11374.20380573352;11565;22344.664830027563;22518.437039074153;22921.656175157386;23031.848407579888;23205.3038408848;8266.173382661806;8291.461055031403;8375.664973401117;8474.533900635524;8499.150084991452;4517.909641807146;4649.744264065509;4745.406824146981;4771.642126840501;4772.236442169236;3559.4660800880074;3590.784552926833;3650.3976843820474;3653.8903832885057;3660.249648821985;586.642148289543;596.1921596237123;614.0267675734011;619.1672200889795;619.9628022318675;632.5824955529329;652.3997921911853;681.6387314723105;684.1619016704498;697.504771612161;9205.723828285161;9638.228941684649;9683.709488715349;9701.805963880683;9781.168600669023;626.9655168965751;653.7744478155029;684.551618689759;692.9757458488929;699.8075529229502;4535.705179163344;4768.61851051915;4775.283707443842;4823.083614113307;4860.465348811628;152567;162603;163927;165481;165655.343446564;93678;98195.56315528922;104026;106767.8418787402;123155;96848.51575742217;97298;98000;110755;111322.44338778417;9457.29070319715;10007.449590272314;10009.749756256151;10084.294099412971;10168.440735759605;53340.1998970008;57529.71235143798;57820.687172512626;59800;60097;84304.57847710968;90080;90900;94342.52828735813;94360.21831412846;12908.806367904677;13074;13082.97213931842;13612.387442565307;13641.38613762403;12260.877391225973;12661.240325580125;14940.402383904522;14945.551633451014;15133.470328538448;11587.130965177477;13753.693399127067;13925.860741392456;13956.651083722989;14263.500777472738;11715.214544947747;13445.731085378042;13788.655283617989;13792.793108103588;14352.784708229594;13566.118202316818;13729;13776.380062897395;13884.722305554034;14155.079919805179;8984.910150898408;9085.409448385833;9107.134822191882;9196.12636799503;9378.343515953818;8521.849550310628;8614;10703.090237329603;10705.625303114353;11413.885861141614 14:51:02 INFO - PROCESS | 1652 | __end_tp_report 14:51:02 INFO - PROCESS | 1652 | __start_cc_report 14:51:02 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,427 14:51:02 INFO - PROCESS | 1652 | __end_cc_report 14:51:02 INFO - PROCESS | 1652 | __startTimestamp1470779462368__endTimestamp 14:51:02 INFO - PROCESS | 1652 | 14:51:02 INFO - PROCESS | 1652 | ------- Summary: start ------- 14:51:02 INFO - PROCESS | 1652 | Number of tests: 6 14:51:02 INFO - PROCESS | 1652 | 14:51:02 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5811.19 Median:6090.88 stddev:623.31 (10.2%) stddev-sans-first:596.33 14:51:02 INFO - PROCESS | 1652 | Values: 3420.5 3457.5 3466.5 3478.3 3483.5 5661.2 5902.3 5910.6 5915.9 5964.9 4814.9 5875.0 5885.0 5908.2 5998.0 5245.1 5299.0 5340.3 5434.1 5447.6 5390.8 5402.5 5446.0 5461.2 5512.7 5203.6 5237.5 5271.1 5310.6 5354.4 5271.8 5275.9 5295.1 5337.0 5350.9 5048.6 5288.5 5294.2 5344.4 5359.7 5722.5 5783.3 5923.1 5938.2 5946.9 6154.4 6164.5 6172.9 6215.9 6223.4 6237.1 6260.5 6266.2 6267.6 6278.3 5827.6 5915.3 5979.1 6006.6 6059.5 6325.7 6356.4 6367.9 6373.9 6419.7 6139.5 6176.2 6184.6 6200.8 6203.3 6112.4 6117.9 6165.8 6172.2 6185.9 6123.9 6142.1 6165.9 6185.0 6203.4 5322.7 5980.5 6119.1 6230.2 6280.6 4763.8 4902.8 4957.8 4984.8 4995.7 4463.2 4510.3 4527.3 4550.1 4567.6 5822.9 5908.6 5913.3 5923.8 5931.7 5112.6 6199.8 6208.6 6240.9 6246.7 5942.6 5942.6 5952.0 5993.9 6005.0 5498.9 5506.1 5511.3 5519.0 5541.7 6217.7 6261.8 6266.2 6398.2 6488.4 6200.3 6231.1 6233.9 6236.3 6274.9 6314.4 6366.6 6373.9 6378.8 6523.7 6131.6 6165.0 6181.6 6284.3 6293.8 6156.6 6214.1 6225.4 6225.6 6228.2 6088.6 6168.8 6238.5 6245.1 6246.8 6090.3 6141.9 6153.9 6247.6 6263.2 6010.1 6090.9 6110.2 6114.8 6139.4 6192.7 6201.5 6214.0 6216.1 6279.8 5907.4 6093.0 6110.6 6137.9 6162.5 14:51:02 INFO - PROCESS | 1652 | 14:51:02 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:80340.61 Median:41347.78 stddev:189340.38 (457.9%) stddev-sans-first:189776.56 14:51:02 INFO - PROCESS | 1652 | Values: 467.4 472.0 486.6 537.2 571.0 31472.7 41441.8 41547.2 41589.6 41689.8 42220.4 42812.6 42846.4 42963.6 43141.6 8580.1 9588.9 9767.3 9791.8 9803.5 9588.9 9725.3 9736.8 9771.1 9776.9 9758.6 9761.3 9774.9 9777.0 9801.5 9723.8 9742.4 9767.5 9780.9 9784.3 9639.3 9729.0 9730.0 9748.9 9755.4 40395.4 40643.2 40734.8 40910.2 40985.2 3084.4 3359.6 3485.8 3500.5 3562.5 29611.3 31223.8 31951.7 32029.0 32125.8 3042.2 3176.9 3183.2 3196.9 3210.7 503746.0 515455.0 520483.0 522289.0 522920.0 54906.0 58057.0 64717.4 65289.7 65576.3 29480.9 36153.5 36216.0 57040.0 68274.5 14487.7 16835.2 16898.7 17026.5 17086.6 11060.3 12876.6 12931.6 12995.7 13030.0 19988.2 20237.4 20290.8 20318.9 20332.5 7221.0 8069.6 8081.4 8166.6 8170.9 879.4 967.5 1030.4 1038.8 1047.7 31088.0 31187.4 31193.7 31455.7 32457.0 1024.7 1036.5 1066.6 1116.2 1134.6 16129.8 16149.4 16305.8 16563.4 16563.9 782945.0 785979.0 982632.0 998647.0 1000226.0 60712.7 61255.7 63902.7 64273.7 64403.7 1378.8 1391.9 1402.7 1403.7 1416.3 31308.4 32026.7 32247.7 32769.8 32782.7 55042.3 55104.4 55523.6 55632.0 55733.7 608142.0 608888.0 614140.0 615799.0 616622.9 44991.0 45732.5 46247.0 46431.0 46493.5 49569.3 50317.5 50801.5 51117.0 51766.5 37262.6 40671.6 40931.0 41253.8 42597.6 39386.0 40407.8 40787.4 41046.6 41992.8 33570.8 39032.0 39930.0 39951.6 39959.0 31453.0 33375.0 36073.6 36529.8 36724.4 22610.8 22734.9 26107.0 26466.2 27029.2 14:51:02 INFO - PROCESS | 1652 | 14:51:02 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:33973.62 Median:25432.62 stddev:91592.88 (360.1%) stddev-sans-first:91815.02 14:51:02 INFO - PROCESS | 1652 | Values: 342.0 344.6 358.9 381.3 387.7 20054.1 20137.7 21226.0 21488.5 21585.7 16360.8 20521.2 21309.6 21319.0 21339.1 5183.6 5937.3 6016.5 6049.6 6161.2 5126.7 5827.3 5982.6 6031.8 6096.5 5892.4 5914.2 5967.5 5989.2 6013.2 5893.8 5942.7 5948.6 5964.2 5966.4 5061.5 5192.6 5353.2 5396.4 5397.0 14217.2 24887.8 25429.4 25435.9 25574.0 2078.6 2438.0 2846.7 2913.6 2953.7 8584.0 10282.6 12637.5 14062.0 15105.5 1544.8 1853.1 1857.4 1870.4 1908.5 114321.0 119362.0 121108.0 123013.4 125547.0 11182.9 11341.3 11558.9 11611.5 11761.5 14342.9 14396.6 14397.3 14398.5 14444.0 8304.7 8585.6 8598.0 8689.9 8726.0 8524.1 8525.3 8534.7 8588.8 8724.0 4454.8 4534.7 4536.1 4567.2 4604.1 1912.6 1927.7 1933.8 1968.8 1975.6 812.9 869.9 875.7 904.7 945.9 17887.8 20930.4 21294.8 21396.0 21500.9 811.9 893.5 938.7 947.8 1073.7 9503.2 10654.6 11495.5 11496.9 11510.6 521988.0 522424.0 523218.8 557433.0 580158.0 128550.0 141457.0 143868.0 156380.0 157182.4 991.2 1023.7 1037.0 1038.6 1040.3 18736.8 19022.8 19419.1 19531.1 19589.0 54670.5 55376.0 58292.7 58622.1 59169.0 60493.7 73959.6 74530.9 74908.3 86323.7 7894.0 7981.8 8060.4 8161.9 8197.8 10671.1 11450.2 11681.0 12671.4 13011.8 9046.0 11013.9 11142.1 11333.9 11514.1 8246.6 10036.9 10566.7 11149.3 11273.9 10589.3 11175.8 11453.5 11459.8 11783.2 7245.6 7900.9 8098.3 8109.3 8273.4 11086.1 11092.2 11120.4 11300.4 11330.8 14:51:02 INFO - PROCESS | 1652 | 14:51:02 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5629.72 Median:4828.35 stddev:3150.96 (65.3%) stddev-sans-first:3143.35 14:51:02 INFO - PROCESS | 1652 | Values: 1345.6 1505.2 1721.5 1834.4 1875.7 7866.2 8262.9 8411.8 8809.9 8826.8 8521.1 8676.6 8690.5 8721.4 8735.6 2297.0 2345.4 2346.0 2346.3 2347.3 2289.5 2297.4 2346.5 2348.9 2354.5 2339.9 2342.1 2351.4 2354.5 2358.8 2296.0 2298.9 2315.2 2317.1 2326.2 1998.2 2323.5 2327.8 2329.8 2334.4 8693.8 8712.8 8780.0 8785.7 8786.6 5130.6 5282.5 5315.3 5323.1 5327.9 3443.5 3483.9 3565.6 3582.4 3637.6 1060.5 1082.9 1094.4 1102.2 1112.8 11219.9 11294.9 11376.2 11393.9 11407.6 3796.8 4489.3 4711.3 4714.1 4731.0 9498.3 9851.9 9855.8 9868.9 9882.2 4778.2 5258.4 5272.6 5291.7 5304.2 4366.5 4674.8 4800.6 4820.1 4836.6 3804.0 3931.0 3943.9 3950.2 4026.8 1279.0 1284.5 1291.1 1294.5 1296.3 927.6 938.5 948.8 959.3 1007.1 5812.2 5822.7 6054.9 6117.7 6130.7 429.5 430.3 436.7 442.5 444.8 3963.6 3990.0 4026.3 4071.4 4111.8 10182.4 10487.6 10568.7 10629.7 10638.3 10441.9 10529.8 10541.0 10556.8 10593.5 8056.8 8154.9 8161.3 8172.4 8183.7 5549.8 5737.5 5749.2 5912.3 5966.6 9821.0 9868.0 9907.5 9934.9 9944.8 8513.4 9590.8 10050.4 10090.3 10103.5 6216.3 6813.8 7187.9 7385.9 7460.3 8184.7 8226.7 8298.0 8324.9 8338.2 7307.6 7355.7 7399.9 7444.3 7569.3 7107.5 7286.1 7362.7 7414.0 7417.3 6902.6 6918.6 7006.4 7015.7 7020.4 4956.6 5041.6 5053.2 5063.2 5132.7 4601.4 4817.8 5003.3 5184.6 5185.6 14:51:02 INFO - PROCESS | 1652 | 14:51:02 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4568.32 Median:4934.79 stddev:1400.84 (28.4%) stddev-sans-first:1367.45 14:51:02 INFO - PROCESS | 1652 | Values: 288.8 306.1 312.7 313.6 316.2 4624.6 5175.8 5607.6 5724.6 5732.1 4467.9 4831.6 4922.4 5654.4 5678.7 4160.7 4351.3 4365.0 4365.3 4382.4 4202.3 4304.3 4322.8 4360.7 4388.6 4279.0 4290.7 4294.4 4306.9 4308.2 3789.9 4301.5 4318.0 4318.0 4325.8 3152.0 3609.4 3733.3 3734.5 3795.9 4758.5 5544.3 5573.3 5597.3 5604.9 4214.7 4966.5 5004.3 5015.8 5018.8 5658.5 6001.9 6025.5 6051.2 6066.4 3463.8 3648.4 4058.8 4089.7 4142.5 5442.6 6290.4 6306.9 6313.0 6337.9 3798.4 4043.9 4166.4 4200.8 4205.2 3659.6 3968.5 4111.5 4133.5 4146.2 4285.0 4885.0 4904.7 4922.3 4949.9 5082.4 5139.7 5992.7 5993.4 5999.3 1122.7 1155.4 1245.9 1419.7 1426.0 777.9 826.6 834.0 839.3 860.2 4367.7 4817.4 4818.8 4832.0 4885.8 4818.7 5051.3 5102.9 5186.6 5230.5 4165.3 4294.0 4447.6 4744.9 4826.0 2464.7 2595.8 2773.9 2780.7 2788.4 5029.8 5283.7 5390.8 5445.4 5468.8 4913.5 4945.3 5257.6 5295.3 5384.0 4679.7 4709.4 5030.5 5412.9 5449.7 4618.8 4791.4 4895.9 5162.5 5205.4 4826.5 4945.0 5112.8 5174.8 5185.5 4356.9 5320.3 5380.7 5407.5 5456.9 3275.7 3569.6 3846.3 4013.4 4031.7 5162.5 5619.4 5858.0 6066.3 6100.1 4924.6 5809.3 5939.6 5945.8 6077.2 4673.0 5862.3 5947.5 6008.3 6040.8 5872.0 5884.5 5897.1 5921.7 5924.9 5444.7 5726.3 5745.0 5909.1 6004.5 5402.4 5622.6 5853.9 5882.1 5895.2 14:51:02 INFO - PROCESS | 1652 | 14:51:02 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24292.48 Median:4526.81 stddev:38815.67 (857.5%) stddev-sans-first:38884.18 14:51:02 INFO - PROCESS | 1652 | Values: 713.2 718.4 774.1 780.8 819.6 15341.6 15692.2 16064.0 16217.8 16243.3 14192.6 14515.1 14588.3 14648.3 14660.3 672.8 840.5 843.6 866.9 868.9 841.9 856.9 857.8 859.2 860.0 794.7 906.9 915.5 918.1 922.1 774.8 905.7 916.9 916.9 916.9 680.1 681.9 683.3 684.5 684.8 14880.7 14896.0 14925.9 14950.2 14978.0 14713.9 14715.4 14765.1 14828.3 14884.9 9906.8 12063.7 12243.5 12431.1 12570.7 3897.3 3920.6 3960.7 4050.8 4051.8 108152.4 109581.0 109992.5 110034.4 118263.0 9532.4 11274.0 11337.8 11374.2 11565.0 22344.7 22518.4 22921.7 23031.8 23205.3 8266.2 8291.5 8375.7 8474.5 8499.2 4517.9 4649.7 4745.4 4771.6 4772.2 3559.5 3590.8 3650.4 3653.9 3660.2 586.6 596.2 614.0 619.2 620.0 632.6 652.4 681.6 684.2 697.5 9205.7 9638.2 9683.7 9701.8 9781.2 627.0 653.8 684.6 693.0 699.8 4535.7 4768.6 4775.3 4823.1 4860.5 152567.0 162603.0 163927.0 165481.0 165655.3 93678.0 98195.6 104026.0 106767.8 123155.0 96848.5 97298.0 98000.0 110755.0 111322.4 9457.3 10007.4 10009.7 10084.3 10168.4 53340.2 57529.7 57820.7 59800.0 60097.0 84304.6 90080.0 90900.0 94342.5 94360.2 12908.8 13074.0 13083.0 13612.4 13641.4 12260.9 12661.2 14940.4 14945.6 15133.5 11587.1 13753.7 13925.9 13956.7 14263.5 11715.2 13445.7 13788.7 13792.8 14352.8 13566.1 13729.0 13776.4 13884.7 14155.1 8984.9 9085.4 9107.1 9196.1 9378.3 8521.8 8614.0 10703.1 10705.6 11413.9 14:51:02 INFO - PROCESS | 1652 | -------- Summary: end -------- 14:51:02 INFO - PROCESS | 1652 | 14:51:02 INFO - TEST-INFO | 1652: exit 0 14:51:02 INFO - TEST-OK | dromaeo_css | took 1114242ms 14:51:02 INFO - TEST-START | kraken 14:51:02 INFO - operating with platform_type : mac_ 14:51:02 INFO - Initialising browser for kraken test... 14:51:02 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpD4byvH/profile http://localhost:49266/getInfo.html) 14:51:05 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 14:51:05 INFO - PROCESS | 1663 | colorDepth:24 14:51:05 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 14:51:05 INFO - PROCESS | 1663 | __metrics 14:51:05 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:51:06 INFO - TEST-INFO | 1663: exit 0 14:51:06 INFO - Browser initialized. 14:51:06 INFO - Running cycle 1/1 for kraken test... 14:51:06 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/T/tmpD4byvH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:18 INFO - PROCESS | 1665 | RSS: Main: 254926848 14:51:18 INFO - PROCESS | 1665 | 14:51:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 14:51:22 INFO - PROCESS | 1665 | RSS: Main: 267673600 14:51:22 INFO - PROCESS | 1665 | 14:51:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 14:51:25 INFO - PROCESS | 1665 | RSS: Main: 276365312 14:51:25 INFO - PROCESS | 1665 | 14:51:29 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 14:51:30 INFO - PROCESS | 1665 | RSS: Main: 279494656 14:51:30 INFO - PROCESS | 1665 | 14:51:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 14:51:32 INFO - PROCESS | 1665 | RSS: Main: 280748032 14:51:32 INFO - PROCESS | 1665 | 14:51:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:51:35 INFO - PROCESS | 1665 | RSS: Main: 281169920 14:51:35 INFO - PROCESS | 1665 | 14:51:38 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:39 INFO - PROCESS | 1665 | RSS: Main: 281673728 14:51:39 INFO - PROCESS | 1665 | 14:51:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:42 INFO - PROCESS | 1665 | RSS: Main: 282275840 14:51:42 INFO - PROCESS | 1665 | 14:51:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 14:51:46 INFO - PROCESS | 1665 | RSS: Main: 283312128 14:51:46 INFO - PROCESS | 1665 | 14:51:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:48 INFO - PROCESS | 1665 | RSS: Main: 283176960 14:51:48 INFO - PROCESS | 1665 | 14:51:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:51:51 INFO - PROCESS | 1665 | RSS: Main: 282775552 14:51:51 INFO - PROCESS | 1665 | 14:51:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:51:54 INFO - PROCESS | 1665 | RSS: Main: 282828800 14:51:54 INFO - PROCESS | 1665 | 14:51:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:51:57 INFO - PROCESS | 1665 | RSS: Main: 282988544 14:51:57 INFO - PROCESS | 1665 | 14:52:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:52:01 INFO - PROCESS | 1665 | RSS: Main: 282931200 14:52:01 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 14:52:03 INFO - PROCESS | 1665 | RSS: Main: 284090368 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | __start_tp_report 14:52:03 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 14:52:03 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 14:52:03 INFO - PROCESS | 1665 | |i|pagename|runs| 14:52:03 INFO - PROCESS | 1665 | |0;ai-astar;106;118;109;119;118;118;119;167;164;118 14:52:03 INFO - PROCESS | 1665 | |1;audio-beat-detection;144;141;163;162;120;155;154;109;161;120 14:52:03 INFO - PROCESS | 1665 | |2;audio-dft;202;203;249;189;275;289;198;203;198;191 14:52:03 INFO - PROCESS | 1665 | |3;audio-fft;84;87;79;145;58;62;60;64;138;59 14:52:03 INFO - PROCESS | 1665 | |4;audio-oscillator;69;73;114;73;74;100;116;69;73;117 14:52:03 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;77;108;77;108;134;130;94;95;135;89 14:52:03 INFO - PROCESS | 1665 | |6;imaging-darkroom;104;94;117;123;128;103;145;91;101;89 14:52:03 INFO - PROCESS | 1665 | |7;imaging-desaturate;90;141;80;131;137;91;117;84;94;108 14:52:03 INFO - PROCESS | 1665 | |8;json-parse-financial;56;54;57;63;62;87;84;86;81;85 14:52:03 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;72;76;74;75;88;79;74;72;71;76 14:52:03 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;87;85;84;86;84;86;88;92;81;116 14:52:03 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;141;147;134;136;179;140;138;139;164;140 14:52:03 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;167;217;165;224;223;206;166;203;231;169 14:52:03 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;69;68;68;68;69;69;84;84;85;82 14:52:03 INFO - PROCESS | 1665 | __end_tp_report 14:52:03 INFO - PROCESS | 1665 | __start_cc_report 14:52:03 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1072 14:52:03 INFO - PROCESS | 1665 | __end_cc_report 14:52:03 INFO - PROCESS | 1665 | __startTimestamp1470779523816__endTimestamp 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | ------- Summary: start ------- 14:52:03 INFO - PROCESS | 1665 | Number of tests: 14 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:125.60 Median:118.50 stddev:21.52 (18.2%) stddev-sans-first:21.62 14:52:03 INFO - PROCESS | 1665 | Values: 106.0 118.0 109.0 119.0 118.0 118.0 119.0 167.0 164.0 118.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:154.50 stddev:19.91 (12.9%) stddev-sans-first:21.12 14:52:03 INFO - PROCESS | 1665 | Values: 144.0 141.0 163.0 162.0 120.0 155.0 154.0 109.0 161.0 120.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:219.70 Median:203.00 stddev:36.97 (18.2%) stddev-sans-first:38.65 14:52:03 INFO - PROCESS | 1665 | Values: 202.0 203.0 249.0 189.0 275.0 289.0 198.0 203.0 198.0 191.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:83.60 Median:63.00 stddev:32.37 (51.4%) stddev-sans-first:34.33 14:52:03 INFO - PROCESS | 1665 | Values: 84.0 87.0 79.0 145.0 58.0 62.0 60.0 64.0 138.0 59.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:71.00 stddev:21.18 (29.8%) stddev-sans-first:21.35 14:52:03 INFO - PROCESS | 1665 | Values: 69.0 73.0 114.0 73.0 74.0 100.0 116.0 69.0 73.0 117.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:104.70 Median:77.00 stddev:22.18 (28.8%) stddev-sans-first:21.14 14:52:03 INFO - PROCESS | 1665 | Values: 77.0 108.0 77.0 108.0 134.0 130.0 94.0 95.0 135.0 89.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:109.50 Median:136.50 stddev:18.22 (13.3%) stddev-sans-first:19.22 14:52:03 INFO - PROCESS | 1665 | Values: 104.0 94.0 117.0 123.0 128.0 103.0 145.0 91.0 101.0 89.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:107.30 Median:82.00 stddev:22.86 (27.9%) stddev-sans-first:23.38 14:52:03 INFO - PROCESS | 1665 | Values: 90.0 141.0 80.0 131.0 137.0 91.0 117.0 84.0 94.0 108.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:71.50 Median:82.50 stddev:14.14 (17.1%) stddev-sans-first:13.84 14:52:03 INFO - PROCESS | 1665 | Values: 56.0 54.0 57.0 63.0 62.0 87.0 84.0 86.0 81.0 85.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:75.50 stddev:4.92 (6.5%) stddev-sans-first:5.04 14:52:03 INFO - PROCESS | 1665 | Values: 72.0 76.0 74.0 75.0 88.0 79.0 74.0 72.0 71.0 76.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:86.00 stddev:9.95 (11.6%) stddev-sans-first:10.53 14:52:03 INFO - PROCESS | 1665 | Values: 87.0 85.0 84.0 86.0 84.0 86.0 88.0 92.0 81.0 116.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:140.50 stddev:14.41 (10.3%) stddev-sans-first:15.17 14:52:03 INFO - PROCESS | 1665 | Values: 141.0 147.0 134.0 136.0 179.0 140.0 138.0 139.0 164.0 140.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.10 Median:211.50 stddev:27.38 (12.9%) stddev-sans-first:26.79 14:52:03 INFO - PROCESS | 1665 | Values: 167.0 217.0 165.0 224.0 223.0 206.0 166.0 203.0 231.0 169.0 14:52:03 INFO - PROCESS | 1665 | 14:52:03 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:75.50 stddev:7.92 (10.5%) stddev-sans-first:8.14 14:52:03 INFO - PROCESS | 1665 | Values: 69.0 68.0 68.0 68.0 69.0 69.0 84.0 84.0 85.0 82.0 14:52:03 INFO - PROCESS | 1665 | -------- Summary: end -------- 14:52:03 INFO - PROCESS | 1665 | 14:52:04 INFO - TEST-INFO | 1665: exit 0 14:52:04 INFO - TEST-OK | kraken | took 61753ms 14:52:04 INFO - SUITE-END | took 1175s 14:52:04 INFO - Completed test suite (00:19:36) 14:52:04 INFO - javascript benchmark 14:52:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7409.069256099623, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3420.4527275635887, 3457.5332330135434, 3466.462698281767, 3478.3043391321735, 3483.512308276843, 5661.23573317603, 5902.2622172228475, 5910.586258961875, 5915.911261331084, 5964.910526342108, 4814.9037019259595, 5874.970625146868, 5884.970575147118, 5908.231929849125, 5997.970010149943, 5245.108331583621, 5298.973505132488, 5340.25236466895, 5434.076207044792, 5447.591430642698, 5390.78436862527, 5402.540784033362, 5446.0, 5461.2354270402175, 5512.6692398456225, 5203.60972927032, 5237.47625237477, 5271.051210782058, 5310.62825602208, 5354.3574771027725, 5271.815486457994, 5275.86810329741, 5295.073362161645, 5337.039332920072, 5350.946490535122, 5048.6465947383695, 5288.497592728685, 5294.1529355303355, 5344.358676958751, 5359.651622644516, 5722.456366645162, 5783.334916484616, 5923.111533270001, 5938.168656388066, 5946.940530594682, 6154.44609985099, 6164.476019538344, 6172.8765424691255, 6215.875682486325, 6223.408776166257, 6237.095621134956, 6260.499160067184, 6266.248050234001, 6267.62394256346, 6278.30938596754, 5827.592068555203, 5915.290165180163, 5979.133025711334, 6006.609570377911, 6059.515238780887, 6325.683715814191, 6356.427921486996, 6367.936320636827, 6373.904391434132, 6419.679016049179, 6139.539534534928, 6176.227971503562, 6184.5980011299125, 6200.782972596027, 6203.286622038433, 6112.381899552462, 6117.9187529241, 6165.8458538536, 6172.197614310201, 6185.907211391833, 6123.862238009563, 6142.1304578115505, 6165.876682466325, 6185.0, 6203.410675985774, 5322.733863306897, 5980.491658209014, 6119.143319935212, 6230.158928544589, 6280.649660323053, 4763.785629646674, 4902.754862256873, 4957.752112394366, 4984.77568509418, 4995.675281106716, 4463.218936686067, 4510.345999830006, 4527.253003254426, 4550.13547425988, 4567.588916997486, 5822.912656310159, 5908.645481271137, 5913.319968203626, 5923.792667256712, 5931.73307201177, 5112.565431938327, 6199.845003874939, 6208.565400421927, 6240.937590624036, 6246.718897649616, 5942.58401911862, 5942.613730107616, 5952.0, 5993.940060599425, 6005.0, 5498.890022199534, 5506.1190209566275, 5511.338639363222, 5518.972405137949, 5541.695206763586, 6217.658028808278, 6261.812145635638, 6266.185395898504, 6398.232212134573, 6488.383603557749, 6200.348963358782, 6231.096491008869, 6233.906491402723, 6236.345183755821, 6274.905876411949, 6314.400131987454, 6366.554341196072, 6373.936260637334, 6378.840528986812, 6523.739050437929, 6131.601445906002, 6164.982777841606, 6181.567290289637, 6284.277308109443, 6293.842653933688, 6156.569040167145, 6214.067889816563, 6225.3774622537385, 6225.595336303126, 6228.22147231596, 6088.6042407243385, 6168.845778855564, 6238.500919926486, 6245.0632405139595, 6246.750129994931, 6090.269167699905, 6141.884937092248, 6153.907691384543, 6247.562670613195, 6263.185785847811, 6010.068439391901, 6090.878182436415, 6110.205673262448, 6114.847128821637, 6139.416755408229, 6192.690365481798, 6201.473173598497, 6214.0, 6216.129741836237, 6279.780207692709, 5907.3797251288, 6092.969535152296, 6110.633361998294, 6137.907931380943, 6162.476189523762], "value": 5773.225932026869, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.41573033707886, 471.96460265480084, 486.56452475034854, 537.2049366936933, 570.9800156994506, 31472.68527314726, 41441.75674729756, 41547.169056618884, 41589.58410415899, 41689.7915510422, 42220.36669449961, 42812.571874281246, 42846.357304640456, 42963.57036429635, 43141.56858431415, 8580.056193818675, 9588.856167157515, 9767.267454940873, 9791.755206119868, 9803.460809655466, 9588.90411095887, 9725.319227654067, 9736.805263894717, 9771.071748183911, 9776.90223097767, 9758.560864761068, 9761.267904907125, 9774.853377199348, 9777.0, 9801.509924503782, 9723.756906077333, 9742.366746161477, 9767.462789546573, 9780.90219097807, 9784.266180036526, 9639.325247232697, 9728.951355243178, 9730.0, 9748.902510974942, 9755.36590121647, 40395.39406908899, 40643.18713625711, 40734.79632601848, 40910.1817963642, 40985.1802963942, 3084.36770462057, 3359.5800524934384, 3485.8082805445692, 3500.474928760681, 3562.4834399011997, 29611.259718506994, 31223.843880780678, 31951.6804831951, 32029.0, 32125.839370802998, 3042.1938186380626, 3176.872925082994, 3183.1564635371647, 3196.9360612787846, 3210.7431405487505, 503746.0, 515455.0, 520483.0, 522289.0, 522919.9999999962, 54906.0, 58057.0, 64717.35282647207, 65289.694206115615, 65576.34423655702, 29480.852595737313, 36153.45769813402, 36216.0, 57040.0, 68274.46569178853, 14487.710245795026, 16835.24241409115, 16898.74651880223, 17026.489205323862, 17086.572835679206, 11060.281081729661, 12876.613701588967, 12931.612051638465, 12995.740085198433, 13029.957603391895, 19988.20047198096, 20237.392878213675, 20290.79709202889, 20318.898405507876, 20332.491687707927, 7220.9638951805955, 8069.556174410463, 8081.393895457864, 8166.632501537326, 8170.918290817134, 879.4107947675074, 967.5404183013012, 1030.4178139351243, 1038.8441733739999, 1047.6542740895486, 31088.0, 31187.376252474824, 31193.68806311953, 31455.685443145274, 32457.0, 1024.6823484719762, 1036.4972988100765, 1066.6000249906285, 1116.190761697779, 1134.5575225661833, 16129.838701612834, 16149.354025838835, 16305.836941630669, 16563.42028029013, 16563.91718041402, 782945.0, 785979.0, 982632.0, 998647.0067649761, 1000226.0, 60712.69643651754, 61255.693721531105, 63902.680486597266, 64273.67863160654, 64403.67798160979, 1378.827646544182, 1391.923444210578, 1402.7194561088027, 1403.677154254527, 1416.3484796993498, 31308.373832522768, 32026.679733203302, 32247.677523225408, 32769.836150819094, 32782.67217327796, 55042.34872953818, 55104.448955509935, 55523.61190970258, 55632.0, 55733.721331393084, 608142.0, 608888.0, 614140.0, 615799.0, 616622.9168854126, 44991.0, 45732.54267457416, 46247.0, 46431.0, 46493.53506464892, 49569.25646115383, 50317.49682503128, 50801.49198508116, 51116.97766044733, 51766.482335176166, 37262.62737372592, 40671.59328406678, 40931.0, 41253.79373103115, 42597.57402425936, 39386.0, 40407.79796101001, 40787.38818917659, 41046.58953410428, 41992.79003604963, 33570.82502112415, 39032.0, 39930.0, 39951.60048399595, 39959.0, 31453.0, 33375.0, 36073.63926360703, 36529.81735091307, 36724.44913326249, 22610.773892260866, 22734.886325568266, 26106.955721770915, 26466.206013819618, 27029.1891243263], "value": 20843.241008497484, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.0, 344.5796128722958, 358.8528703231674, 381.3402813133279, 387.66854339539674, 20054.089452556756, 20137.697934530974, 21226.0, 21488.462788430297, 21585.704857708548, 16360.754588681179, 20521.17915283387, 21309.57380852382, 21319.0, 21339.146434142614, 5183.585313174955, 5937.287525496947, 6016.548758843082, 6049.637021778685, 6161.19904412428, 5126.666766660173, 5827.300723913137, 5982.581219314649, 6031.849203769897, 6096.542759293071, 5892.440218179266, 5914.172015917775, 5967.462928336449, 5989.221401217836, 6013.1882195903645, 5893.79371721992, 5942.732577034044, 5948.643081415107, 5964.1650168976375, 5966.389074949782, 5061.519155680205, 5192.584593232532, 5353.170258609922, 5396.406395296514, 5396.973015134939, 14217.21805300708, 24887.751122488724, 25429.364265893317, 25435.872820635963, 25574.0, 2078.5842831433774, 2438.0491608272787, 2846.6868644449096, 2913.6212292402065, 2953.689862564421, 8583.95708021462, 10282.640107596199, 12637.49450021998, 14062.0, 15105.54683359501, 1544.7564710408117, 1853.1197681101503, 1857.4149143019906, 1870.3827736846808, 1908.4942490240098, 114321.0, 119362.0, 121108.0, 123013.38493307476, 125547.0, 11182.888171118184, 11341.26281791681, 11558.884411155948, 11611.535538578362, 11761.471008768805, 14342.928285358506, 14396.568102956928, 14397.280135993158, 14398.496052638317, 14444.0, 8304.6678132874, 8585.570721464026, 8597.957010215034, 8689.869651955225, 8726.04013558508, 8524.14758524155, 8525.31797456202, 8534.74395768128, 8588.785280368042, 8723.956380218186, 4454.844080457168, 4534.682572219979, 4536.138133754576, 4567.177907976529, 4604.1252162089095, 1912.6461604602914, 1927.7012063130237, 1933.8162874526897, 1968.773591037049, 1975.5950030243766, 812.8943237379103, 869.860822268434, 875.695214130953, 904.7285814255697, 945.8912225094065, 17887.821121788875, 20930.37208883736, 21294.78705212959, 21396.0, 21500.92495375225, 811.8863359129726, 893.4594570285014, 938.6949241496541, 947.8293907096651, 1073.742301847551, 9503.239740820718, 10654.62708805188, 11495.482703278372, 11496.885031149748, 11510.59712910044, 521988.0, 522424.0, 523218.76781232463, 557433.0, 580158.0, 128550.0, 141457.0, 143868.0, 156380.0, 157182.42817571908, 991.2367477042637, 1023.7389465686202, 1037.025196315461, 1038.6364772329623, 1040.2977989856815, 18736.81263187351, 19022.809771902103, 19419.126139324046, 19531.12109955027, 19589.0, 54670.453295466534, 55376.0, 58292.708536457045, 58622.120668189156, 59169.0, 60493.69753151206, 73959.63020184865, 74530.88203676841, 74908.25091749012, 86323.70514442414, 7894.0132483439575, 7981.760547183594, 8060.39547033963, 8161.877571836309, 8197.83604327922, 10671.092957098734, 11450.198486105892, 11681.0, 12671.429785659482, 13011.828935395859, 9045.95477022637, 11013.944930275296, 11142.108631309313, 11333.943330283295, 11514.136439766884, 8246.587670616565, 10036.899631003596, 10566.735831604272, 11149.331040137293, 11273.887261127611, 10589.258751887293, 11175.832362514731, 11453.48459319316, 11459.828102578635, 11783.175177737476, 7245.637718113968, 7900.881486777588, 8098.271155596025, 8109.27016568488, 8273.420860539705, 11086.057685096857, 11092.168087393638, 11120.388378639253, 11300.434978251218, 11330.773384532098], "value": 9590.28677098743, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.5963211036687, 1505.2398538737937, 1721.535185499915, 1834.4221570205375, 1875.690511065675, 7866.213378662131, 8262.876056859144, 8411.83176336473, 8809.942806863177, 8826.823463530725, 8521.062683104854, 8676.566171691422, 8690.478571285727, 8721.43310684805, 8735.606897689604, 2296.9540609187848, 2345.44881952741, 2346.0, 2346.343023953296, 2347.260612906929, 2289.473421113145, 2297.448612333036, 2346.4837735698206, 2348.9295321140307, 2354.482013956935, 2339.894704738291, 2342.0982921575146, 2351.423901144222, 2354.517323948595, 2358.8348815582917, 2295.988520057406, 2298.8735619540917, 2315.235972129193, 2317.0731707316954, 2326.1742081561056, 1998.2206939293687, 2323.488832456857, 2327.837051406402, 2329.77867102625, 2334.3813889319345, 8693.7826554336, 8712.825743485095, 8780.034196238408, 8785.692500762507, 8786.60460279289, 5130.640855140142, 5282.498162674539, 5315.282436871012, 5323.148296272578, 5327.866803329948, 3443.483477478373, 3483.8780642677384, 3565.625609311037, 3582.444721068239, 3637.6180501047274, 1060.5015642647943, 1082.94953894722, 1094.441834664319, 1102.2064113838023, 1112.7830073135742, 11219.943900280528, 11294.887051129466, 11376.203665743402, 11393.943030284878, 11407.600733974354, 3796.7532110412735, 4489.32660100981, 4711.293306004059, 4714.104320179155, 4730.95269047312, 9498.287628427895, 9851.867035291034, 9855.80288394228, 9868.901310986941, 9882.160016398686, 4778.187708089564, 5258.447862974333, 5272.578193744491, 5291.682499049993, 5304.177852432879, 4366.476022877275, 4674.813007479663, 4800.591949684246, 4820.084184005028, 4836.613070954315, 3804.0, 3931.0, 3943.940840887389, 3950.249452603996, 4026.7583944963394, 1278.9936050319689, 1284.5054653958107, 1291.0510774580675, 1294.4692676002983, 1296.293520031585, 927.6150397585062, 938.4603852784539, 948.8434408322687, 959.2901253072815, 1007.1087087927237, 5812.215350927655, 5822.7088645567555, 6054.909176362358, 6117.663528505975, 6130.693465326716, 429.5210839913474, 430.30290928695086, 436.7401396169274, 442.4579889635171, 444.83096423358916, 3963.6432721055244, 3990.0024993751563, 4026.335654617014, 4071.42999980003, 4111.835526578903, 10182.439965801952, 10487.632932847466, 10568.735781605368, 10629.681109566725, 10638.255322127377, 10441.947790261, 10529.789404211873, 10540.9986051325, 10556.841647375295, 10593.470326483644, 8056.758297251092, 8154.8776768348525, 8161.347092232726, 8172.387070969701, 8183.71357002502, 5549.834534747587, 5737.540996720169, 5749.223854779719, 5912.349641539341, 5966.582339236385, 9820.950895245478, 9868.0, 9907.45508997012, 9934.900650993397, 9944.801103978025, 8513.40406171562, 9590.808183836423, 10050.447225402673, 10090.293679442368, 10103.49482525856, 6216.347283535345, 6813.761518346834, 7187.892181617175, 7385.926140738524, 7460.253974602496, 8184.672613095409, 8226.712065077694, 8298.0, 8324.875126872981, 8338.207870252316, 7307.561546307238, 7355.7057717690695, 7399.852002960019, 7444.292792184734, 7569.318761311288, 7107.538010029331, 7286.125664920243, 7362.705491780269, 7413.999110120065, 7417.258274172756, 6902.551334163464, 6918.584884906922, 7006.439484841098, 7015.6842942066705, 7020.438364930691, 4956.603471722182, 5041.621878359211, 5053.166227572409, 5063.1898896176435, 5132.692038477703, 4601.401817763804, 4817.8313759018265, 5003.3245511856885, 5184.559312458483, 5185.559227465707], "value": 4464.361734843152, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.77619844620415, 306.058868977893, 312.67481818908334, 313.5798030638944, 316.1511342046605, 4624.60690841278, 5175.844724658257, 5607.607467477278, 5724.627899186555, 5732.054211055176, 4467.888302792432, 4831.613470922327, 4922.43392009919, 5654.406287339832, 5678.744456499458, 4160.7295525790805, 4351.303791393378, 4365.0, 4365.279728844736, 4382.364557139213, 4202.327627579588, 4304.289792184286, 4322.82708691652, 4360.672949528782, 4388.561143885618, 4279.037216626265, 4290.721103128287, 4294.377315289281, 4306.9420711295015, 4308.224519586473, 3789.8863034108745, 4301.526832048487, 4318.0, 4318.01371369169, 4325.82696692132, 3152.0, 3609.3864043112735, 3733.328000959826, 3734.506197520986, 3795.9430608540893, 4758.452777930548, 5544.306961629796, 5573.331200255955, 5597.328320601554, 5604.915926261109, 4214.672378200857, 4966.50334966504, 5004.324416203803, 5015.84952451427, 5018.7992480300745, 5658.547316214693, 6001.909971350433, 6025.548083893726, 6051.152838602599, 6066.393360663942, 3463.8268086595567, 3648.361536731088, 4058.7767672777986, 4089.6932730045364, 4142.544320124784, 5442.6462279951675, 6290.43386095249, 6306.936930630681, 6312.968435157841, 6337.87324253517, 3798.3732684107367, 4043.9283589848715, 4166.437530933345, 4200.844767688849, 4205.201011807747, 3659.6157403472785, 3968.503937007874, 4111.519852852971, 4133.545310015896, 4146.170765846843, 4284.964641795123, 4885.0, 4904.730239836843, 4922.310876477296, 4949.876253093629, 5082.390113186368, 5139.691618502827, 5992.711567013026, 5993.400659934059, 5999.340072592011, 1122.7080958950733, 1155.4165146600913, 1245.9252444853337, 1419.7160567886465, 1426.0089237979505, 777.941654375924, 826.5867066466767, 833.98332033359, 839.3369238301796, 860.242986172177, 4367.67242456817, 4817.421909370828, 4818.759062046884, 4832.0, 4885.8045678173185, 4818.68678535894, 5051.318072060225, 5102.923456148161, 5186.576859272862, 5230.529252367305, 4165.250594750212, 4293.957060429356, 4447.644188464915, 4744.905101897943, 4825.9758701206265, 2464.6937123324665, 2595.8442493450452, 2773.9057011956247, 2780.7497325240824, 2788.372616161388, 5029.84910452687, 5283.735813209324, 5390.784368625211, 5445.37378201504, 5468.7539060742365, 4913.484084171182, 4945.282933974553, 5257.631965762436, 5295.346211114319, 5383.977044361559, 4679.742614156254, 4709.3877795887, 5030.465707959108, 5412.891742165135, 5449.727513624303, 4618.782984167551, 4791.353167322367, 4895.902081958412, 5162.457941916195, 5205.375354957429, 4826.541478559531, 4944.975275123601, 5112.821051263188, 5174.844754657366, 5185.51095474167, 4356.869293921188, 5320.334958130234, 5380.735527151194, 5407.513323800719, 5456.863578410413, 3275.6724327567053, 3569.5894972078545, 3846.3461211593535, 4013.3578627419474, 4031.6573091286396, 5162.5095615916425, 5619.353774316006, 5858.0, 6066.272047354169, 6100.054491553817, 4924.606031517542, 5809.331926828469, 5939.584229103922, 5945.762169513171, 6077.171382029293, 4672.962574326715, 5862.267216597926, 5947.524198064058, 6008.309044459943, 6040.848978775566, 5872.0, 5884.46931840892, 5897.115432685132, 5921.6743079131065, 5924.933511967887, 5444.727763611882, 5726.282115365457, 5744.971275143765, 5909.143174239625, 6004.459598636144, 5402.432744561765, 5622.582289615505, 5853.9121913172185, 5882.117682347511, 5895.170318247179], "value": 4112.7256923578525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.2368365848541, 718.3929579505319, 774.0827119862963, 780.7735756630577, 819.6024927909963, 15341.616459588517, 15692.215389230521, 16064.0, 16217.75673364899, 16243.269052892618, 14192.645183870409, 14515.056521326107, 14588.270586470688, 14648.26758662068, 14660.340284687189, 672.7510820996238, 840.4663038970267, 843.6035063520151, 866.9263112635402, 868.8696695495695, 841.8610929196675, 856.8586183279751, 857.8498762716531, 859.2095272349453, 859.995700021499, 794.7403365665427, 906.9319801014917, 915.5239275576696, 918.1002617434917, 922.1424075609681, 774.8062984253936, 905.7237542549552, 916.8762217100673, 916.8945571259324, 916.9495677737722, 680.0886811672383, 681.9488538359593, 683.2689022745664, 684.4729558240177, 684.7842929477199, 14880.70238595222, 14896.031757935807, 14925.92537037308, 14950.177740224284, 14978.026428282126, 14713.852861471463, 14715.411383544646, 14765.114093154445, 14828.258587070603, 14884.925575372054, 9906.827341287237, 12063.698407539794, 12243.510259589606, 12431.12982091254, 12570.748585028248, 3897.31796935538, 3920.607939206085, 3960.7425517341567, 4050.797460126982, 4051.8379264829373, 108152.37771433435, 109581.0, 109992.4500377501, 110034.44982775114, 118263.0, 9532.380395274286, 11274.041706455044, 11337.773244535229, 11374.20380573352, 11565.0, 22344.664830027563, 22518.437039074153, 22921.656175157386, 23031.848407579888, 23205.3038408848, 8266.173382661806, 8291.461055031403, 8375.664973401117, 8474.533900635524, 8499.150084991452, 4517.909641807146, 4649.744264065509, 4745.406824146981, 4771.642126840501, 4772.236442169236, 3559.4660800880074, 3590.784552926833, 3650.3976843820474, 3653.8903832885057, 3660.249648821985, 586.642148289543, 596.1921596237123, 614.0267675734011, 619.1672200889795, 619.9628022318675, 632.5824955529329, 652.3997921911853, 681.6387314723105, 684.1619016704498, 697.504771612161, 9205.723828285161, 9638.228941684649, 9683.709488715349, 9701.805963880683, 9781.168600669023, 626.9655168965751, 653.7744478155029, 684.551618689759, 692.9757458488929, 699.8075529229502, 4535.705179163344, 4768.61851051915, 4775.283707443842, 4823.083614113307, 4860.465348811628, 152567.0, 162603.0, 163927.0, 165481.0, 165655.343446564, 93678.0, 98195.56315528922, 104026.0, 106767.8418787402, 123155.0, 96848.51575742217, 97298.0, 98000.0, 110755.0, 111322.44338778417, 9457.29070319715, 10007.449590272314, 10009.749756256151, 10084.294099412971, 10168.440735759605, 53340.1998970008, 57529.71235143798, 57820.687172512626, 59800.0, 60097.0, 84304.57847710968, 90080.0, 90900.0, 94342.52828735813, 94360.21831412846, 12908.806367904677, 13074.0, 13082.97213931842, 13612.387442565307, 13641.38613762403, 12260.877391225973, 12661.240325580125, 14940.402383904522, 14945.551633451014, 15133.470328538448, 11587.130965177477, 13753.693399127067, 13925.860741392456, 13956.651083722989, 14263.500777472738, 11715.214544947747, 13445.731085378042, 13788.655283617989, 13792.793108103588, 14352.784708229594, 13566.118202316818, 13729.0, 13776.380062897395, 13884.722305554034, 14155.079919805179, 8984.910150898408, 9085.409448385833, 9107.134822191882, 9196.12636799503, 9378.343515953818, 8521.849550310628, 8614.0, 10703.090237329603, 10705.625303114353, 11413.885861141614], "value": 7806.012801423213, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1634.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 109.0, 119.0, 118.0, 118.0, 119.0, 167.0, 164.0, 118.0], "value": 125.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 163.0, 162.0, 120.0, 155.0, 154.0, 109.0, 161.0, 120.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 203.0, 249.0, 189.0, 275.0, 289.0, 198.0, 203.0, 198.0, 191.0], "value": 219.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 79.0, 145.0, 58.0, 62.0, 60.0, 64.0, 138.0, 59.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 114.0, 73.0, 74.0, 100.0, 116.0, 69.0, 73.0, 117.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 108.0, 77.0, 108.0, 134.0, 130.0, 94.0, 95.0, 135.0, 89.0], "value": 104.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 94.0, 117.0, 123.0, 128.0, 103.0, 145.0, 91.0, 101.0, 89.0], "value": 109.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 141.0, 80.0, 131.0, 137.0, 91.0, 117.0, 84.0, 94.0, 108.0], "value": 107.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 57.0, 63.0, 62.0, 87.0, 84.0, 86.0, 81.0, 85.0], "value": 71.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 74.0, 75.0, 88.0, 79.0, 74.0, 72.0, 71.0, 76.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 84.0, 86.0, 84.0, 86.0, 88.0, 92.0, 81.0, 116.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 147.0, 134.0, 136.0, 179.0, 140.0, 138.0, 139.0, 164.0, 140.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 217.0, 165.0, 224.0, 223.0, 206.0, 166.0, 203.0, 231.0, 169.0], "value": 197.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 84.0, 84.0, 85.0, 82.0], "value": 74.6, "unit": "score"}]}]} 14:52:05 INFO - Return code: 0 14:52:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:52:05 ERROR - # TBPL SUCCESS # 14:52:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:52:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:52:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:52:05 INFO - 2016-08-09 14:52:05.143 screenresolution[1670:10169] starting screenresolution argv=screenresolution get 14:52:05 INFO - 2016-08-09 14:52:05.146 screenresolution[1670:10169] Display 0: 1600x1200x32@60 14:52:05 INFO - 2016-08-09 14:52:05.152 screenresolution[1671:10172] starting screenresolution argv=screenresolution list 14:52:05 INFO - Available Modes on Display 0 14:52:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:52:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:52:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:52:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:52:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:52:05 INFO - Intel Iris: 14:52:05 INFO - Chipset Model: Intel Iris 14:52:05 INFO - Type: GPU 14:52:05 INFO - Bus: Built-In 14:52:05 INFO - VRAM (Dynamic, Max): 1536 MB 14:52:05 INFO - Vendor: Intel (0x8086) 14:52:05 INFO - Device ID: 0x0a2e 14:52:05 INFO - Revision ID: 0x0009 14:52:05 INFO - Displays: 14:52:05 INFO - Display: 14:52:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:52:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:52:05 INFO - Display Serial Number: 1600x1200 60 14:52:05 INFO - Main Display: Yes 14:52:05 INFO - Mirror: Off 14:52:05 INFO - Online: Yes 14:52:05 INFO - Rotation: Supported 14:52:05 INFO - Return code: 0 14:52:05 INFO - Running post-action listener: _resource_record_post_action 14:52:05 INFO - [mozharness: 2016-08-09 21:52:05.392224Z] Finished run-tests step (success) 14:52:05 INFO - Running post-run listener: _resource_record_post_run 14:52:05 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 37258240; Write bytes: 703739904; Read time: 240; Write time: 1953 14:52:05 INFO - TinderboxPrint: CPU usage
54.6% 14:52:05 INFO - TinderboxPrint: I/O read bytes / time
37,258,240 / 240 14:52:05 INFO - TinderboxPrint: I/O write bytes / time
703,739,904 / 1,953 14:52:05 INFO - TinderboxPrint: CPU idle
2,198.1 (45.4%) 14:52:05 INFO - TinderboxPrint: CPU system
981.1 (20.2%) 14:52:05 INFO - TinderboxPrint: CPU user
1,666.5 (34.4%) 14:52:05 INFO - TinderboxPrint: Swap in / out
440,332,288 / 0 14:52:05 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384369152; Write bytes: 379537408; Read time: 29053; Write time: 766 14:52:05 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 36295680; Write bytes: 296783872; Read time: 227; Write time: 1124 14:52:05 INFO - Running post-run listener: _upload_blobber_files 14:52:05 INFO - Blob upload gear active. 14:52:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:52:05 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'] 14:52:05 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 14:52:06 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:52:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:52:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:07 INFO - (blobuploader) - INFO - Done attempting. 14:52:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:52:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:08 INFO - (blobuploader) - INFO - Done attempting. 14:52:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:52:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:52:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:11 INFO - (blobuploader) - INFO - Done attempting. 14:52:11 INFO - (blobuploader) - INFO - Iteration through files over. 14:52:11 INFO - Return code: 0 14:52:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:52:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:52:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d17c2e33f26d59e570b85e33ddcc94e8de385c334c7e68452709a8d2da895534243592c9eee14000954d53146ca35328bc2953fd44bf7572496879ea783d9fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dca22e092591a0a5191cf81e4c91a7fa83de6fe79068da6d46e294c24a0c7ef184a11f2f9d30f5fc5bc0026947ef385dff50fda0821164fc9df387d1718983ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3ce253ab5754bd4f72b168a01e3070c8b7848ab6cc9e2c631bddc0919cf3d9ae301509a3399a3892eaba3841c0e7f50633ec5dc14deb7bd52e410b743b29674"} 14:52:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:52:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:52:11 INFO - Contents: 14:52:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d17c2e33f26d59e570b85e33ddcc94e8de385c334c7e68452709a8d2da895534243592c9eee14000954d53146ca35328bc2953fd44bf7572496879ea783d9fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dca22e092591a0a5191cf81e4c91a7fa83de6fe79068da6d46e294c24a0c7ef184a11f2f9d30f5fc5bc0026947ef385dff50fda0821164fc9df387d1718983ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3ce253ab5754bd4f72b168a01e3070c8b7848ab6cc9e2c631bddc0919cf3d9ae301509a3399a3892eaba3841c0e7f50633ec5dc14deb7bd52e410b743b29674"} 14:52:11 INFO - Running post-run listener: copy_logs_to_upload_dir 14:52:11 INFO - Copying logs to upload dir... 14:52:11 INFO - mkdir: /builds/slave/test/build/upload/logs 14:52:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.209428 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-09 14:52:11.206404) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 14:52:11.210122) ========= 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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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/2d17c2e33f26d59e570b85e33ddcc94e8de385c334c7e68452709a8d2da895534243592c9eee14000954d53146ca35328bc2953fd44bf7572496879ea783d9fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dca22e092591a0a5191cf81e4c91a7fa83de6fe79068da6d46e294c24a0c7ef184a11f2f9d30f5fc5bc0026947ef385dff50fda0821164fc9df387d1718983ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3ce253ab5754bd4f72b168a01e3070c8b7848ab6cc9e2c631bddc0919cf3d9ae301509a3399a3892eaba3841c0e7f50633ec5dc14deb7bd52e410b743b29674"} build_url:https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011099 build_url: 'https://queue.taskcluster.net/v1/task/aPvvfon6Qa-Qv1M0nwNcFQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d17c2e33f26d59e570b85e33ddcc94e8de385c334c7e68452709a8d2da895534243592c9eee14000954d53146ca35328bc2953fd44bf7572496879ea783d9fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dca22e092591a0a5191cf81e4c91a7fa83de6fe79068da6d46e294c24a0c7ef184a11f2f9d30f5fc5bc0026947ef385dff50fda0821164fc9df387d1718983ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3ce253ab5754bd4f72b168a01e3070c8b7848ab6cc9e2c631bddc0919cf3d9ae301509a3399a3892eaba3841c0e7f50633ec5dc14deb7bd52e410b743b29674"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 14:52:11.243242) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 14:52:11.243627) ========= 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.qLfn2N4aMy/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.9XCK4s4qQG/Listeners TMPDIR=/var/folders/8z/76ns34yj20gfly9p4jksxfwm00000w/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.005168 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 14:52:11.293775) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 14:52:11.294157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 14:52:11.295115) ========= ========= Total master_lag: 0.60 =========