builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0014 starttime: 1461329798.82 results: success (0) buildid: 20160419211331 builduid: 3b917d3ba8a04cb5a3589a514138e6b8 revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:38.818810) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:38.819363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:38.819700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:38.845495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:38.845830) ========= 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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-04-22 05:56:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2016-04-22 05:56:39 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165470 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:39.031368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:39.031727) ========= 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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.020345 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:39.080796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:39.081190) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bf3a35b355f0b48ac1020c47198053af9944a493 --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 bf3a35b355f0b48ac1020c47198053af9944a493 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G6qIoYX9SX/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.skn7Gg3PwP/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-04-22 05:56:39,154 truncating revision to first 12 chars 2016-04-22 05:56:39,154 Setting DEBUG logging. 2016-04-22 05:56:39,154 attempt 1/10 2016-04-22 05:56:39,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bf3a35b355f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 05:56:39,742 unpacking tar archive at: fx-team-bf3a35b355f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.838781 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:39.943132) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:39.943457) ========= script_repo_revision: bf3a35b355f0b48ac1020c47198053af9944a493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:39.943850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:39.944115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:56:39.959262) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-22 05:56:39.959638) ========= /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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 05:56:40 INFO - MultiFileLogger online at 20160422 05:56:40 in /builds/slave/test 05:56:40 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 05:56:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:40 INFO - {'append_to_log': False, 05:56:40 INFO - 'base_work_dir': '/builds/slave/test', 05:56:40 INFO - 'blob_upload_branch': 'Fx-Team', 05:56:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:40 INFO - 'branch': 'Fx-Team', 05:56:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:40 INFO - 'config_files': ('talos/mac_config.py',), 05:56:40 INFO - 'default_actions': ('clobber', 05:56:40 INFO - 'read-buildbot-config', 05:56:40 INFO - 'download-and-extract', 05:56:40 INFO - 'populate-webroot', 05:56:40 INFO - 'create-virtualenv', 05:56:40 INFO - 'install', 05:56:40 INFO - 'run-tests'), 05:56:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:40 INFO - 'download_minidump_stackwalk': True, 05:56:40 INFO - 'download_symbols': 'ondemand', 05:56:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:40 INFO - 'installer_path': 'installer.exe', 05:56:40 INFO - 'log_level': 'info', 05:56:40 INFO - 'log_name': 'talos', 05:56:40 INFO - 'log_to_console': True, 05:56:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:56:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:56:40 INFO - 'opt_config_files': (), 05:56:40 INFO - 'pip_index': False, 05:56:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:56:40 INFO - 'cmd': ('bash', 05:56:40 INFO - '-c', 05:56:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:56:40 INFO - 'enabled': True, 05:56:40 INFO - 'halt_on_failure': False, 05:56:40 INFO - 'name': 'check_screen_resolution'},), 05:56:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:56:40 INFO - 'cmd': ('bash', 05:56:40 INFO - '-c', 05:56:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:56:40 INFO - 'enabled': True, 05:56:40 INFO - 'halt_on_failure': False, 05:56:40 INFO - 'name': 'check_screen_resolution'},), 05:56:40 INFO - 'run_cmd_checks_enabled': True, 05:56:40 INFO - 'sps_profile': False, 05:56:40 INFO - 'sps_profile_interval': 0, 05:56:40 INFO - 'suite': 'dromaeojs-e10s', 05:56:40 INFO - 'system_bits': '32', 05:56:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:40 INFO - 'title': 't-yosemite-r7-0014', 05:56:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:40 INFO - 'use_talos_json': True, 05:56:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:40 INFO - 'work_dir': 'build'} 05:56:40 INFO - ##### 05:56:40 INFO - ##### Running clobber step. 05:56:40 INFO - ##### 05:56:40 INFO - Running pre-action listener: _resource_record_pre_action 05:56:40 INFO - Running main action method: clobber 05:56:40 INFO - rmtree: /builds/slave/test/build 05:56:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:41 INFO - Running post-action listener: _resource_record_post_action 05:56:41 INFO - ##### 05:56:41 INFO - ##### Running read-buildbot-config step. 05:56:41 INFO - ##### 05:56:41 INFO - Running pre-action listener: _resource_record_pre_action 05:56:41 INFO - Running main action method: read_buildbot_config 05:56:41 INFO - Using buildbot properties: 05:56:41 INFO - { 05:56:41 INFO - "project": "", 05:56:41 INFO - "product": "firefox", 05:56:41 INFO - "script_repo_revision": "production", 05:56:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:56:41 INFO - "repository": "", 05:56:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:56:41 INFO - "buildid": "20160419211331", 05:56:41 INFO - "pgo_build": "False", 05:56:41 INFO - "basedir": "/builds/slave/test", 05:56:41 INFO - "buildnumber": 716, 05:56:41 INFO - "slavename": "t-yosemite-r7-0014", 05:56:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:56:41 INFO - "platform": "yosemite_r7", 05:56:41 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:56:41 INFO - "branch": "fx-team", 05:56:41 INFO - "repo_path": "integration/fx-team", 05:56:41 INFO - "revision": "bf3a35b355f0b48ac1020c47198053af9944a493", 05:56:41 INFO - "stage_platform": "macosx64", 05:56:41 INFO - "builduid": "3b917d3ba8a04cb5a3589a514138e6b8", 05:56:41 INFO - "slavebuilddir": "test" 05:56:41 INFO - } 05:56:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:56:41 INFO - Running post-action listener: _resource_record_post_action 05:56:41 INFO - ##### 05:56:41 INFO - ##### Running download-and-extract step. 05:56:41 INFO - ##### 05:56:41 INFO - Running pre-action listener: _resource_record_pre_action 05:56:41 INFO - Running main action method: download_and_extract 05:56:41 INFO - mkdir: /builds/slave/test/build/tests 05:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:41 INFO - https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:56:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:56:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:56:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:56:43 INFO - Downloaded 1199 bytes. 05:56:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:56:43 INFO - Using the following test package requirements: 05:56:43 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:56:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:56:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:56:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:43 INFO - u'jsshell-mac.zip'], 05:56:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:56:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:56:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:56:43 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:56:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:56:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:56:43 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:56:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:43 INFO - https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:56:44 INFO - Downloaded 18095501 bytes. 05:56:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:56:47 INFO - Return code: 0 05:56:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:47 INFO - https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:56:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:56:48 INFO - Downloaded 18095501 bytes. 05:56:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:56:51 INFO - Return code: 0 05:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:51 INFO - https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:56:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:56:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:56:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:56:52 INFO - Downloaded 10845952 bytes. 05:56:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:56:53 INFO - Return code: 0 05:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:53 INFO - https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:56:56 INFO - Downloaded 110002250 bytes. 05:56:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:56:56 INFO - mkdir: /builds/slave/test/properties 05:56:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:56:56 INFO - Writing to file /builds/slave/test/properties/build_url 05:56:56 INFO - Contents: 05:56:56 INFO - build_url:https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:56:57 INFO - Running post-action listener: _resource_record_post_action 05:56:57 INFO - Running post-action listener: set_extra_try_arguments 05:56:57 INFO - ##### 05:56:57 INFO - ##### Running populate-webroot step. 05:56:57 INFO - ##### 05:56:57 INFO - Running pre-action listener: _resource_record_pre_action 05:56:57 INFO - Running main action method: populate_webroot 05:56:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:56:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:56:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:56:57 INFO - '--tppagecycles', 05:56:57 INFO - '7'], 05:56:57 INFO - 'tests': ['tsvgm']}}, 05:56:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:56:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:56:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:56:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:56:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:56:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:56:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:57 INFO - 'talos_options': ['--disable-e10s'], 05:56:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:57 INFO - 'talos_options': ['--disable-e10s'], 05:56:57 INFO - 'tests': ['damp', 'tps']}, 05:56:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:57 INFO - 'tests': ['damp', 'tps']}, 05:56:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:56:57 INFO - 'tests': ['dromaeo_dom']}, 05:56:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:56:57 INFO - 'tests': ['a11yr', 05:56:57 INFO - 'ts_paint', 05:56:57 INFO - 'tpaint', 05:56:57 INFO - 'sessionrestore', 05:56:57 INFO - 'sessionrestore_no_auto_restore', 05:56:57 INFO - 'tabpaint']}, 05:56:57 INFO - 'other-e10s': {'tests': ['a11yr', 05:56:57 INFO - 'ts_paint', 05:56:57 INFO - 'tpaint', 05:56:57 INFO - 'sessionrestore', 05:56:57 INFO - 'sessionrestore_no_auto_restore', 05:56:57 INFO - 'tabpaint']}, 05:56:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:56:57 INFO - 'ts_paint', 05:56:57 INFO - 'tpaint', 05:56:57 INFO - 'sessionrestore', 05:56:57 INFO - 'sessionrestore_no_auto_restore', 05:56:57 INFO - 'tabpaint']}, 05:56:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:56:57 INFO - 'ts_paint', 05:56:57 INFO - 'tpaint', 05:56:57 INFO - 'sessionrestore', 05:56:57 INFO - 'sessionrestore_no_auto_restore', 05:56:57 INFO - 'tabpaint']}, 05:56:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:56:57 INFO - 'tests': ['a11yr', 05:56:57 INFO - 'ts_paint', 05:56:57 INFO - 'tpaint', 05:56:57 INFO - 'sessionrestore', 05:56:57 INFO - 'sessionrestore_no_auto_restore', 05:56:57 INFO - 'tabpaint']}, 05:56:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:56:57 INFO - 'tests': ['a11yr', 05:56:57 INFO - 'ts_paint', 05:56:57 INFO - 'tpaint', 05:56:57 INFO - 'sessionrestore', 05:56:57 INFO - 'sessionrestore_no_auto_restore', 05:56:57 INFO - 'tabpaint']}, 05:56:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:56:57 INFO - 'tests': ['tsvgx', 05:56:57 INFO - 'tsvgr_opacity', 05:56:57 INFO - 'tart', 05:56:57 INFO - 'tscrollx', 05:56:57 INFO - 'cart']}, 05:56:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:56:57 INFO - 'tsvgr_opacity', 05:56:57 INFO - 'tart', 05:56:57 INFO - 'tscrollx', 05:56:57 INFO - 'cart']}, 05:56:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:57 INFO - 'talos_options': ['--disable-e10s'], 05:56:57 INFO - 'tests': ['tp5o']}, 05:56:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:57 INFO - 'tests': ['tp5o']}, 05:56:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:57 INFO - 'talos_options': ['--disable-e10s', 05:56:57 INFO - '--xperf_path', 05:56:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:57 INFO - 'tests': ['tp5n']}, 05:56:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:57 INFO - 'talos_options': ['--xperf_path', 05:56:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:57 INFO - 'tests': ['tp5n']}}, 05:56:57 INFO - 'talos.zip': {'path': '', 05:56:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:56:57 INFO - Running post-action listener: _resource_record_post_action 05:56:57 INFO - ##### 05:56:57 INFO - ##### Running create-virtualenv step. 05:56:57 INFO - ##### 05:56:57 INFO - Running pre-action listener: _resource_record_pre_action 05:56:57 INFO - Running main action method: create_virtualenv 05:56:57 INFO - Creating virtualenv /builds/slave/test/build/venv 05:56:57 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 05:56:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:56:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:57 INFO - Using real prefix '/tools/python27' 05:56:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:56:58 INFO - Installing distribute.............................................................................................................................................................................................done. 05:57:01 INFO - Installing pip.................done. 05:57:01 INFO - Return code: 0 05:57:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:01 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 0x1094c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a357c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109360e00>, '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 0x1091c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb20>, '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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 05:57:01 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 05:57:01 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 05:57:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6qIoYX9SX/Render', 05:57:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:01 INFO - 'HOME': '/Users/cltbld', 05:57:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:01 INFO - 'LOGNAME': 'cltbld', 05:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:01 INFO - 'MOZ_NO_REMOTE': '1', 05:57:01 INFO - 'NO_EM_RESTART': '1', 05:57:01 INFO - 'PAGER': '/bin/cat', 05:57:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:01 INFO - 'PWD': '/builds/slave/test', 05:57:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:01 INFO - 'SHELL': '/bin/bash', 05:57:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skn7Gg3PwP/Listeners', 05:57:01 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 05:57:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:01 INFO - 'USER': 'cltbld', 05:57:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:01 INFO - 'XPC_FLAGS': '0x0', 05:57:01 INFO - 'XPC_SERVICE_NAME': '0', 05:57:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:01 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 05:57:01 INFO - Cleaning up... 05:57:01 INFO - Return code: 0 05:57:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:01 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a357c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109360e00>, '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 0x1091c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb20>, '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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 05:57:01 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>=0.7.1'] in /builds/slave/test/build 05:57:01 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>=0.7.1 05:57:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6qIoYX9SX/Render', 05:57:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:01 INFO - 'HOME': '/Users/cltbld', 05:57:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:01 INFO - 'LOGNAME': 'cltbld', 05:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:01 INFO - 'MOZ_NO_REMOTE': '1', 05:57:01 INFO - 'NO_EM_RESTART': '1', 05:57:01 INFO - 'PAGER': '/bin/cat', 05:57:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:01 INFO - 'PWD': '/builds/slave/test', 05:57:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:01 INFO - 'SHELL': '/bin/bash', 05:57:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skn7Gg3PwP/Listeners', 05:57:01 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 05:57:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:01 INFO - 'USER': 'cltbld', 05:57:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:01 INFO - 'XPC_FLAGS': '0x0', 05:57:01 INFO - 'XPC_SERVICE_NAME': '0', 05:57:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:01 INFO - Downloading/unpacking psutil>=0.7.1 05:57:01 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 05:57:01 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 05:57:01 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 05:57:01 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 05:57:01 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 05:57:01 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 05:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:57:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:04 INFO - Installing collected packages: psutil 05:57:04 INFO - Running setup.py install for psutil 05:57:04 INFO - building 'psutil._psutil_osx' extension 05:57:04 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 05:57:04 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 05:57:04 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 05:57:04 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 05:57:05 INFO - building 'psutil._psutil_posix' extension 05:57:05 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 05:57:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:57:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:57:05 INFO - ^ 05:57:05 INFO - 1 warning generated. 05:57:05 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 05:57:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:05 INFO - Successfully installed psutil 05:57:05 INFO - Cleaning up... 05:57:05 INFO - Return code: 0 05:57:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a357c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109360e00>, '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 0x1091c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb20>, '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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 05:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:57:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6qIoYX9SX/Render', 05:57:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:05 INFO - 'HOME': '/Users/cltbld', 05:57:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:05 INFO - 'LOGNAME': 'cltbld', 05:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:05 INFO - 'MOZ_NO_REMOTE': '1', 05:57:05 INFO - 'NO_EM_RESTART': '1', 05:57:05 INFO - 'PAGER': '/bin/cat', 05:57:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:05 INFO - 'PWD': '/builds/slave/test', 05:57:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:05 INFO - 'SHELL': '/bin/bash', 05:57:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skn7Gg3PwP/Listeners', 05:57:05 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 05:57:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:05 INFO - 'USER': 'cltbld', 05:57:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:05 INFO - 'XPC_FLAGS': '0x0', 05:57:05 INFO - 'XPC_SERVICE_NAME': '0', 05:57:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:57:08 INFO - Installing collected packages: mozsystemmonitor 05:57:08 INFO - Running setup.py install for mozsystemmonitor 05:57:08 INFO - Successfully installed mozsystemmonitor 05:57:08 INFO - Cleaning up... 05:57:08 INFO - Return code: 0 05:57:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1094c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a357c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109360e00>, '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 0x1091c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb20>, '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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 05:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6qIoYX9SX/Render', 05:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:08 INFO - 'HOME': '/Users/cltbld', 05:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:08 INFO - 'LOGNAME': 'cltbld', 05:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:08 INFO - 'MOZ_NO_REMOTE': '1', 05:57:08 INFO - 'NO_EM_RESTART': '1', 05:57:08 INFO - 'PAGER': '/bin/cat', 05:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:08 INFO - 'PWD': '/builds/slave/test', 05:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:08 INFO - 'SHELL': '/bin/bash', 05:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skn7Gg3PwP/Listeners', 05:57:08 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 05:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:08 INFO - 'USER': 'cltbld', 05:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:08 INFO - 'XPC_FLAGS': '0x0', 05:57:08 INFO - 'XPC_SERVICE_NAME': '0', 05:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:57:08 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 05:57:08 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 05:57:08 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 05:57:08 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 05:57:08 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 05:57:08 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 05:57:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:57:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:11 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 05:57:12 INFO - Downloading docopt-0.6.1.tar.gz 05:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:12 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:12 INFO - Running setup.py install for blobuploader 05:57:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:57:12 INFO - Running setup.py install for requests 05:57:12 INFO - Running setup.py install for docopt 05:57:13 INFO - Successfully installed blobuploader requests docopt 05:57:13 INFO - Cleaning up... 05:57:13 INFO - Return code: 0 05:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:13 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 0x1094c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a357c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109360e00>, '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 0x1091c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb20>, '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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 05:57:13 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 05:57:13 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 05:57:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6qIoYX9SX/Render', 05:57:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:13 INFO - 'HOME': '/Users/cltbld', 05:57:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:13 INFO - 'LOGNAME': 'cltbld', 05:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:13 INFO - 'MOZ_NO_REMOTE': '1', 05:57:13 INFO - 'NO_EM_RESTART': '1', 05:57:13 INFO - 'PAGER': '/bin/cat', 05:57:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:13 INFO - 'PWD': '/builds/slave/test', 05:57:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:13 INFO - 'SHELL': '/bin/bash', 05:57:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skn7Gg3PwP/Listeners', 05:57:13 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 05:57:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:13 INFO - 'USER': 'cltbld', 05:57:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:13 INFO - 'XPC_FLAGS': '0x0', 05:57:13 INFO - 'XPC_SERVICE_NAME': '0', 05:57:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-49pFqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-0sBTpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-iy9Hd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-8wdrrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-iZZnGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:13 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-3b57TX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-lKICPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-uU39zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Ga_FAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Ih4KQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-2dIOr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-WqQbRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-c_PEK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-mPjsbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-xyZ8va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:14 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-miwL3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:15 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-q_I7ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:15 INFO - Running setup.py install for manifestparser 05:57:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:15 INFO - Running setup.py install for mozcrash 05:57:15 INFO - Running setup.py install for mozdebug 05:57:15 INFO - Running setup.py install for mozdevice 05:57:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:57:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:15 INFO - Running setup.py install for mozfile 05:57:15 INFO - Running setup.py install for mozhttpd 05:57:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:16 INFO - Running setup.py install for mozinfo 05:57:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:16 INFO - Running setup.py install for mozInstall 05:57:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:16 INFO - Running setup.py install for mozleak 05:57:16 INFO - Running setup.py install for mozlog 05:57:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:16 INFO - Running setup.py install for moznetwork 05:57:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:16 INFO - Running setup.py install for mozprocess 05:57:16 INFO - Running setup.py install for mozprofile 05:57:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:17 INFO - Running setup.py install for mozrunner 05:57:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:17 INFO - Running setup.py install for mozscreenshot 05:57:17 INFO - Running setup.py install for moztest 05:57:17 INFO - Running setup.py install for mozversion 05:57:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:17 INFO - Cleaning up... 05:57:17 INFO - Return code: 0 05:57:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:17 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 0x1094c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a357c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109360e00>, '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 0x1091c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb20>, '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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 05:57:17 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 05:57:17 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 05:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6qIoYX9SX/Render', 05:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:17 INFO - 'HOME': '/Users/cltbld', 05:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:17 INFO - 'LOGNAME': 'cltbld', 05:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:17 INFO - 'MOZ_NO_REMOTE': '1', 05:57:17 INFO - 'NO_EM_RESTART': '1', 05:57:17 INFO - 'PAGER': '/bin/cat', 05:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:17 INFO - 'PWD': '/builds/slave/test', 05:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:17 INFO - 'SHELL': '/bin/bash', 05:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skn7Gg3PwP/Listeners', 05:57:17 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 05:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:17 INFO - 'USER': 'cltbld', 05:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:17 INFO - 'XPC_FLAGS': '0x0', 05:57:17 INFO - 'XPC_SERVICE_NAME': '0', 05:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:17 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-2apex3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:18 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)) 05:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-2OKUsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:18 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)) 05:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-qhVg_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:18 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)) 05:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-SwO8YP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:18 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)) 05:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-KiePXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:18 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)) 05:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ZDiBLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:18 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)) 05:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-cJ93Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:18 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)) 05:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-VPYyVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:18 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)) 05:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-2Pt2kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:18 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)) 05:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:18 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-z0odhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:19 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-qkHoRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:19 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)) 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:19 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Lq2Ypz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:19 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-2vtqLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:19 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)) 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:19 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-57vMb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:19 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-DT60Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:19 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)) 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:19 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-K4ODZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:19 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)) 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:19 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-l3CFH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 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)) 05:57:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:19 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 05:57:19 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 05:57:19 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 05:57:19 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 05:57:19 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 05:57:19 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 05:57:22 INFO - Downloading blessings-1.6.tar.gz 05:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:22 INFO - Installing collected packages: blessings 05:57:22 INFO - Running setup.py install for blessings 05:57:22 INFO - Successfully installed blessings 05:57:22 INFO - Cleaning up... 05:57:22 INFO - Return code: 0 05:57:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:22 INFO - Reading from file tmpfile_stdout 05:57:22 INFO - Current package versions: 05:57:22 INFO - blessings == 1.6 05:57:22 INFO - blobuploader == 1.2.4 05:57:22 INFO - docopt == 0.6.1 05:57:22 INFO - manifestparser == 1.1 05:57:22 INFO - mozInstall == 1.12 05:57:22 INFO - mozcrash == 0.17 05:57:22 INFO - mozdebug == 0.1 05:57:22 INFO - mozdevice == 0.48 05:57:22 INFO - mozfile == 1.2 05:57:22 INFO - mozhttpd == 0.7 05:57:22 INFO - mozinfo == 0.9 05:57:22 INFO - mozleak == 0.1 05:57:22 INFO - mozlog == 3.1 05:57:22 INFO - moznetwork == 0.27 05:57:22 INFO - mozprocess == 0.22 05:57:22 INFO - mozprofile == 0.28 05:57:22 INFO - mozrunner == 6.11 05:57:22 INFO - mozscreenshot == 0.1 05:57:22 INFO - mozsystemmonitor == 0.0 05:57:22 INFO - moztest == 0.7 05:57:22 INFO - mozversion == 1.4 05:57:22 INFO - psutil == 3.1.1 05:57:22 INFO - requests == 1.2.3 05:57:22 INFO - wsgiref == 0.1.2 05:57:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:22 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 0x1094c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a357c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109360e00>, '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 0x1091c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb20>, '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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 05:57:22 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 05:57:22 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 05:57:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6qIoYX9SX/Render', 05:57:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:22 INFO - 'HOME': '/Users/cltbld', 05:57:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:22 INFO - 'LOGNAME': 'cltbld', 05:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:22 INFO - 'MOZ_NO_REMOTE': '1', 05:57:22 INFO - 'NO_EM_RESTART': '1', 05:57:22 INFO - 'PAGER': '/bin/cat', 05:57:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:22 INFO - 'PWD': '/builds/slave/test', 05:57:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:22 INFO - 'SHELL': '/bin/bash', 05:57:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skn7Gg3PwP/Listeners', 05:57:22 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 05:57:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:22 INFO - 'USER': 'cltbld', 05:57:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:22 INFO - 'XPC_FLAGS': '0x0', 05:57:22 INFO - 'XPC_SERVICE_NAME': '0', 05:57:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 INFO - Cleaning up... 05:57:23 INFO - Return code: 0 05:57:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:23 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 0x1094c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a357c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109360e00>, '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 0x1091c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb20>, '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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 05:57:23 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 05:57:23 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 05:57:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6qIoYX9SX/Render', 05:57:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:23 INFO - 'HOME': '/Users/cltbld', 05:57:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:23 INFO - 'LOGNAME': 'cltbld', 05:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:23 INFO - 'MOZ_NO_REMOTE': '1', 05:57:23 INFO - 'NO_EM_RESTART': '1', 05:57:23 INFO - 'PAGER': '/bin/cat', 05:57:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:23 INFO - 'PWD': '/builds/slave/test', 05:57:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:23 INFO - 'SHELL': '/bin/bash', 05:57:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skn7Gg3PwP/Listeners', 05:57:23 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 05:57:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:23 INFO - 'USER': 'cltbld', 05:57:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:23 INFO - 'XPC_FLAGS': '0x0', 05:57:23 INFO - 'XPC_SERVICE_NAME': '0', 05:57:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:23 INFO - Downloading/unpacking jsonschema 05:57:23 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 05:57:23 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 05:57:23 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 05:57:23 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 05:57:23 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 05:57:23 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 05:57:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:57:25 INFO - Downloading/unpacking functools32 (from jsonschema) 05:57:25 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 05:57:25 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 05:57:25 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 05:57:25 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 05:57:25 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 05:57:25 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 05:57:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:57:26 INFO - warning: no files found matching '*.txt' 05:57:26 INFO - no previously-included directories found matching 'build' 05:57:26 INFO - no previously-included directories found matching 'dist' 05:57:26 INFO - no previously-included directories found matching '.git*' 05:57:26 INFO - Installing collected packages: jsonschema, functools32 05:57:26 INFO - Running setup.py install for functools32 05:57:26 INFO - warning: no files found matching '*.txt' 05:57:26 INFO - no previously-included directories found matching 'build' 05:57:26 INFO - no previously-included directories found matching 'dist' 05:57:26 INFO - no previously-included directories found matching '.git*' 05:57:26 INFO - Successfully installed jsonschema functools32 05:57:26 INFO - Cleaning up... 05:57:26 INFO - Return code: 0 05:57:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094c1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1094d1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1a357c0b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109360e00>, '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 0x1091c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb20>, '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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 05:57: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', 'flake8'] in /builds/slave/test/build 05:57: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 flake8 05:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6qIoYX9SX/Render', 05:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:26 INFO - 'HOME': '/Users/cltbld', 05:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:26 INFO - 'LOGNAME': 'cltbld', 05:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:26 INFO - 'MOZ_NO_REMOTE': '1', 05:57:26 INFO - 'NO_EM_RESTART': '1', 05:57:26 INFO - 'PAGER': '/bin/cat', 05:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:26 INFO - 'PWD': '/builds/slave/test', 05:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:26 INFO - 'SHELL': '/bin/bash', 05:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skn7Gg3PwP/Listeners', 05:57:26 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 05:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:26 INFO - 'USER': 'cltbld', 05:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:26 INFO - 'XPC_FLAGS': '0x0', 05:57:26 INFO - 'XPC_SERVICE_NAME': '0', 05:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:26 INFO - Downloading/unpacking flake8 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:57:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:57:29 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 05:57:29 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 05:57:29 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 05:57:29 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 05:57:29 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 05:57:29 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 05:57:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:57:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:57:29 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 05:57:29 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 05:57:29 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 05:57:29 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 05:57:29 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 05:57:29 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 05:57:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:57:29 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 05:57:29 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 05:57:29 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 05:57:30 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 05:57:30 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 05:57:30 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 05:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:57:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:30 INFO - no previously-included directories found matching 'docs/_build' 05:57:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:57:30 INFO - Running setup.py install for pep8 05:57:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:30 INFO - no previously-included directories found matching 'docs/_build' 05:57:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:57:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:57:30 INFO - Cleaning up... 05:57:30 INFO - Return code: 0 05:57:30 INFO - Running post-action listener: _resource_record_post_action 05:57:30 INFO - Running post-action listener: _start_resource_monitoring 05:57:30 INFO - Starting resource monitoring. 05:57:30 INFO - ##### 05:57:30 INFO - ##### Running install step. 05:57:30 INFO - ##### 05:57:30 INFO - Running pre-action listener: _resource_record_pre_action 05:57:30 INFO - Running main action method: install 05:57:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:31 INFO - Reading from file tmpfile_stdout 05:57:31 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:31 INFO - Reading from file tmpfile_stdout 05:57:31 INFO - Output received: 05:57:31 INFO - Usage: mozinstall [options] installer 05:57:31 INFO - Options: 05:57:31 INFO - -h, --help show this help message and exit 05:57:31 INFO - -d DEST, --destination=DEST 05:57:31 INFO - Directory to install application into. [default: 05:57:31 INFO - "/builds/slave/test"] 05:57:31 INFO - --app=APP Application being installed. [default: firefox] 05:57:31 INFO - mkdir: /builds/slave/test/build/application 05:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:58:04 INFO - Reading from file tmpfile_stdout 05:58:04 INFO - Output received: 05:58:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:58:04 INFO - Running post-action listener: _resource_record_post_action 05:58:04 INFO - ##### 05:58:04 INFO - ##### Running run-tests step. 05:58:04 INFO - ##### 05:58:04 INFO - Running pre-action listener: _resource_record_pre_action 05:58:04 INFO - Running main action method: run_tests 05:58:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:58:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:58:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:58:04 INFO - 2016-04-22 05:58:04.898 screenresolution[1980:26112] starting screenresolution argv=screenresolution get 05:58:04 INFO - 2016-04-22 05:58:04.901 screenresolution[1980:26112] Display 0: 1600x1200x32@60 05:58:04 INFO - 2016-04-22 05:58:04.907 screenresolution[1981:26114] starting screenresolution argv=screenresolution list 05:58:04 INFO - Available Modes on Display 0 05:58:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:58:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:58:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:58:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:58:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:58:05 INFO - Intel Iris: 05:58:05 INFO - Chipset Model: Intel Iris 05:58:05 INFO - Type: GPU 05:58:05 INFO - Bus: Built-In 05:58:05 INFO - VRAM (Dynamic, Max): 1536 MB 05:58:05 INFO - Vendor: Intel (0x8086) 05:58:05 INFO - Device ID: 0x0a2e 05:58:05 INFO - Revision ID: 0x0009 05:58:05 INFO - Displays: 05:58:05 INFO - Display: 05:58:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:58:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:58:05 INFO - Display Serial Number: 1600x1200 60 05:58:05 INFO - Main Display: Yes 05:58:05 INFO - Mirror: Off 05:58:05 INFO - Online: Yes 05:58:05 INFO - Rotation: Supported 05:58:05 INFO - Return code: 0 05:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:05 INFO - Python 2.7.3 05:58:05 INFO - Return code: 0 05:58:05 INFO - grabbing minidump binary from tooltool 05:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:05 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109360e00>, '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 0x1091c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10935bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:05 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 05:58:05 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 05:58:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:05 INFO - Return code: 0 05:58:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:58:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:58:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:58:06 INFO - Return code: 0 05:58:06 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/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 05:58:06 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/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --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 05:58:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G6qIoYX9SX/Render', 05:58:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:58:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:58:06 INFO - 'HOME': '/Users/cltbld', 05:58:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:58:06 INFO - 'LOGNAME': 'cltbld', 05:58:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:06 INFO - 'MOZ_NO_REMOTE': '1', 05:58:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:06 INFO - 'NO_EM_RESTART': '1', 05:58:06 INFO - 'PAGER': '/bin/cat', 05:58:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:06 INFO - 'PWD': '/builds/slave/test', 05:58:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:58:06 INFO - 'SHELL': '/bin/bash', 05:58:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skn7Gg3PwP/Listeners', 05:58:06 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 05:58:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:58:06 INFO - 'USER': 'cltbld', 05:58:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:58:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:06 INFO - 'XPC_FLAGS': '0x0', 05:58:06 INFO - 'XPC_SERVICE_NAME': '0', 05:58:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:58:06 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/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 05:58:06 INFO - mozversion application_buildid: 20160419211331 05:58:06 INFO - mozversion application_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 05:58:06 INFO - mozversion application_display_name: Nightly 05:58:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:06 INFO - mozversion application_name: Firefox 05:58:06 INFO - mozversion application_remotingname: firefox 05:58:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:58:06 INFO - mozversion application_vendor: Mozilla 05:58:06 INFO - mozversion application_version: 48.0a1 05:58:06 INFO - mozversion platform_buildid: 20160419211331 05:58:06 INFO - mozversion platform_changeset: bf3a35b355f0b48ac1020c47198053af9944a493 05:58:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:58:06 INFO - mozversion platform_version: 48.0a1 05:58:06 INFO - using testdate: 1461329886 05:58:06 INFO - actual date: 1461329886 05:58:06 INFO - starting webserver on 'localhost:52965' 05:58:06 INFO - SUITE-START | Running 2 tests 05:58:06 INFO - TEST-START | dromaeo_css 05:58:06 INFO - operating with platform_type : mac_ 05:58:06 INFO - Initialising browser for dromaeo_css test... 05:58:06 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmp70L8Zw/profile http://localhost:52965/getInfo.html) 05:58:09 INFO - PROCESS | 1999 | __metrics Screen width/height:1600/1200 05:58:09 INFO - PROCESS | 1999 | colorDepth:24 05:58:09 INFO - PROCESS | 1999 | Browser inner width/height: 1024/689 05:58:09 INFO - PROCESS | 1999 | __metrics 05:58:09 ERROR - PROCESS | 1999 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:58:10 INFO - TEST-INFO | 1999: exit 0 05:58:10 INFO - Browser initialized. 05:58:10 INFO - Running cycle 1/1 for dromaeo_css test... 05:58:10 INFO - TEST-INFO | started process 2002 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmp70L8Zw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:22 INFO - PROCESS | 2002 | RSS: Main: 247894016 05:58:22 INFO - PROCESS | 2002 | 05:59:11 INFO - PROCESS | 2002 | 1461329951772 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] 06:01:22 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52965/tests/dromaeo/cssquery-ext.html) 06:01:24 INFO - PROCESS | 2002 | RSS: Main: 261349376 06:01:24 INFO - PROCESS | 2002 | 06:04:26 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-ext.html (next: http://localhost:52965/tests/dromaeo/cssquery-jquery.html) 06:04:27 INFO - PROCESS | 2002 | RSS: Main: 271970304 06:04:27 INFO - PROCESS | 2002 | 06:07:28 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52965/tests/dromaeo/cssquery-mootools.html) 06:07:29 INFO - PROCESS | 2002 | RSS: Main: 273969152 06:07:29 INFO - PROCESS | 2002 | 06:10:31 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52965/tests/dromaeo/cssquery-prototype.html) 06:10:31 INFO - PROCESS | 2002 | RSS: Main: 275521536 06:10:31 INFO - PROCESS | 2002 | 06:13:34 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52965/tests/dromaeo/cssquery-yui.html) 06:13:35 INFO - PROCESS | 2002 | RSS: Main: 278380544 06:13:35 INFO - PROCESS | 2002 | 06:16:38 INFO - PROCESS | 2002 | Cycle 1(1): loaded http://localhost:52965/tests/dromaeo/cssquery-yui.html (next: http://localhost:52965/tests/dromaeo/cssquery-dojo.html) 06:16:38 INFO - PROCESS | 2002 | RSS: Main: 279552000 06:16:38 INFO - PROCESS | 2002 | 06:16:38 INFO - PROCESS | 2002 | __start_tp_report 06:16:38 INFO - PROCESS | 2002 | _x_x_mozilla_page_load 06:16:38 INFO - PROCESS | 2002 | _x_x_mozilla_page_load_details 06:16:38 INFO - PROCESS | 2002 | |i|pagename|runs| 06:16:38 INFO - PROCESS | 2002 | |0;dojo.html;3354.2452948086675;3438.656134386561;3478.2521757822065;3490.2147016921194;3545.5036294918714;5779.653220806749;5806.564507661927;5809.651420914748;5836.503897168745;5851;5599.384067752544;5792.594518383704;5811.418858114186;5854.560907931901;5965.284165900098;5163.380394352674;5249.763760630762;5259.447757985414;5276.287701160332;5319.547838433718;318.7811839459988;5148.150555158413;5234.0840352938085;5270.657407268515;5302.284191634138;5172.663776854492;5218.791248350061;5237.13587258102;5240.816571420001;5280.947190528084;5135.281060651474;5275.709835959021;5292.735363231862;5306.204069389584;5313.867153321159;5191.195364718475;5192.091384007821;5205.427402985669;5264.184051472028;5308.734563271821;5646.435356464362;5718.256626638552;5719.48524632785;5775.711214439261;5816.8836623267725;6125.662799505643;6161.4146656067605;6184.412480814315;6231.906521402183;6277.2153480814895;6202.286737025254;6243.438090571825;6251.812445626639;6263.906041409383;6269.3730626937395;5947.553933454921;5955.851103722398;5960.791372301992;5989.221401217857;6001.819945401601;6174.938250617436;6233.1273621693;6257.843553911098;6335.651539165298;6338.334474880164;6221.09794079865;6226.968865155645;6243.500519958392;6253.499720022387;6255.562110652301;6175.505959523227;6195.659238741822;6236.064590311489;6248.062790581449;6251.062340648939;6098.847528811815;6132.171952247653;6213.689315534205;6251.59364641306;6269.62382257066;6112.290716697417;6160.537959653044;6253.312135665074;6255.43701066897;6261.342559031327;4883.633727470454;4961.776720047606;4962.230854217602;4978.228374601942;4997.025580011936;3706.7405281630026;4404.867853964386;4440.933385999213;4487.192305384997;4524.366588677588;4348.391225228471;5609.803656872072;5753.827385178452;5862.325832529228;5870.324912635102;6232.594881332699;6249.156363890907;6253.999360102362;6275.6862156891975;6310.242770867433;4965.0566392385335;5810.779736255434;5868.38381969887;5948.10778383246;5972.910406343908;4808.374911261513;5527.723613819293;5531.3362396511875;5536.197251398525;5541.750621222055;6236;6428.100065990765;6450.290468048604;6465.676716164267;6468.935310646927;6144.678894037804;6194.287656919512;6205.441510264098;6208.875822483616;6209.0996805462055;6419.8395040122505;6443.130177426175;6449.5485316027425;6453.225612926291;6470.773522926675;5570.6657600544095;5808.36108028125;6105.206323177958;6167.969160154171;6169.81490555284;5706.343770466449;6145.617236121837;6205.937940620536;6206.596571222856;6210.099535567408;5722.62802917809;6165.938340616716;6191.133241346305;6200.627962322275;6214.533909956862;6120.510359171167;6135.477655820289;6142.877142457215;6186;6215.223097112861;5834.095715164156;5972.820815375546;5987.520998320211;6063.211782468251;6110.3461303294;6133.417325354084;6167.876642467215;6170.197874276315;6195.566310358232;6200.255969283715;5956.910646340395;6039.124326972476;6075.270967483753;6123.877522449437;6248.531360148098 06:16:38 INFO - PROCESS | 2002 | |1;ext.html;541.0585581088906;556.5436342199398;563.6280055163592;613.3069631316612;620.5004970998348;37086.51653933843;37869.48522059121;37963.86108416748;37966.81016594913;38105.80947095268;39265;39783.204335913266;39863.003424914394;39984.80007599958;40102;9240.768980775467;9440.386374885646;9485.146336829685;9492.905070949306;9532.380395274286;9342.626294948228;9436.528173591327;9533.856992145124;9547.61809527618;9555.952220238889;9540.427574345562;9573.473458959754;9588.328816982814;9606.75983100421;9607.615695372177;9478.71563853082;9500.23998080152;9537.14165725088;9548.474833884133;9592.808143837085;9332.766680833034;9413.152816246502;9450.669226577105;9481.525923703855;9488.051194880525;30974.845125774453;32350.514742278883;38081.80959095214;38503.22993540142;38636.80681596602;2522.445062086338;2811.5923191137376;3083.3833233353193;3408.3694516514524;3425.9657403425895;25537.723113844233;25707.485850283076;25788.484230315476;27107.45785084287;27614.861925690442;2636.2618466829317;2738.192233291184;2748.7938404619736;2752.4357506711276;2770.612114303999;284351;427004;507970;516425;517819;58906.52733681606;59033.40966590279;59411.51471213254;59446.70276648589;59513.40486595079;61054.69472652697;62026.37973620206;62250.68874655688;67562.66218668876;69520.6523967377;16740.83259167417;16914.238859251363;16995.74506382405;17047.91476042612;17058.658826823394;12572.245665260114;12604.747905042032;12956.676083097998;13066.34668266583;13081.542146024844;15921.203939802963;18267.36064237772;18979.81020189808;19268.614627707368;19359.612807743768;8136.616775148239;8343.582820858932;8392.244697977088;8394.286485648667;8399;917.5366439947917;988.7478692933256;992.8609994600762;1005.4872015272117;1086.3156211586809;28204.012859549817;29614;29897;29943.42967551747;30191.849040754656;981.6220755009373;1077.3320541264309;1112.6383925224334;1149.5746573767592;1249.4814651919532;13003.052664711504;13437.260950647613;14396.496122635657;14532.782008269884;14787.556373308818;625909;632459.8377008085;635330;635984;638637;58242.7087864558;58856.11715824266;59734.70132649396;59800;60151.39848601545;1369.7465968795805;1399.9090059146326;1486.1009089500913;1488.4120772294882;1493.7161939231728;23756.406089847893;27924.795956084094;28079;28628.427431450837;28648.57027144553;45322;45469.317960229964;46090.539094608626;46142.077158457316;46233.29617205419;572642;576111;577196;577624;578278;26598.734012659625;37886.81056594809;40485.79757101196;41767.791161044;41865.37201941913;41885.371719424846;42739.78630106829;42760.358594620484;42839.35740963826;43174;33660.158496037795;34685.65314346925;35854;36249;36341.81829090838;29227.70772292335;30840;35835.46246806248;36032.63967360293;36258;36160.92632126193;36239.094022649646;36313.63686363103;36739.26521469609;36827;27244.863775680995;29022.709772902846;30655.467226639026;31576;32610.347793044482;24034;24143.879280603483;24434.26697199087;24506.019759210147;24618.753812461648 06:16:38 INFO - PROCESS | 2002 | |2;jquery.html;392.3291172095716;392.59170462718777;393.82868452223283;400.0977795072112;406.3701263042284;13344.933275333635;19553.120109595067;19811.50471238216;20212.797872021292;20277.391678249656;19605.92167430791;19656.70514942277;19997.100130494127;21045.473863153427;21250.46873828155;5697.857553561153;5753.395893431192;5875.206847075654;5930.644161350333;5942.2869255689375;5843.620164689303;5882.941170588304;5907.645541267538;5908.556858235628;5917.993941030035;5597.692126933017;5778.653280803144;5790.449907258825;5839.0949402842625;5842.88314233715;5539.086050801613;5782.3639399666;5814.912776308338;5817.7091145442555;5835.679037652927;5091.847244582631;5110.4634013428795;5127.3847138343635;5146.922796158061;5167.069927413064;20039;25030.624540631907;25774.840132194095;26186.607200892002;26339.868300658374;2102.9684554731693;2202.973264596575;2341.7072865891764;2390.091765129257;2534.835235709673;14729;14944.62638434037;14959;15325.770113448307;15519.767203491956;1665.9083750393725;1734.9392771253072;1760.9207585658676;1777.9555511112326;1845.1604519943528;105358;108358;108375;109063.81872362508;109178;11020.779584408267;11206.21556491054;11789.764204715857;11818.645440636794;11995.820062699066;14211.85788142126;14409.13545187292;14506.709865802624;14581;14585.635359115895;8754.124587541195;8920.776980575538;8930.910690893008;8958.68644597436;9036.683716069905;8923.15230053144;8949.59726812282;8970.968338641009;8971.910280897107;9064.864027039599;6858.485613579001;6915.585064896122;6927.272636373209;6931.7227310907;6959.408450281681;1655.337864854044;1912.7704675438758;1918.5395505078682;1936.9225230990885;1947.57153426246;873.8252349530119;958.5782255807422;961.3414810854587;970.277143528062;1066.909312708413;15831.604209894846;20523.384298471068;20988.26541071055;21281.36155915325;21517.56964860694;970.8932017478072;982.6364245229311;1029.6807989523272;1110.2838669058574;1112.777444511101;11033.448327583588;11298;11433.485493152828;11490.597829075943;11605.76788464243;580764;588865;594711;605286;607111;101575;110261;111151;114295;114402;1024.8257796174669;1041.578160844859;1052.1267348101057;1060.0459586372172;1062.5377960587016;17902.194401251716;18673.253069877595;18759.53101172427;18792.906035469736;19083.713744294124;46993;47690.52309477;48016.5198348026;48331.758341209475;48536;65714.34285657082;65776;66447.33552664412;67107;68069.65965170143;8001.839963200587;8024.438289319692;8106.39202059836;8390.202930721573;8572.957135214285;12654.746905061664;12738.044646651724;12758.362081896053;13035.15271507349;13055.934720326337;11014.063804576701;11196.552137914392;11256.986871181633;11610.303381797119;11676.94161529187;10797.62208322705;10885.619003334845;11267.661970140909;11385.772284554429;11426.02878755315;9345.579448924678;11333.886661133283;11405.486753095965;11754.412279386168;11821;8222.588870556328;8228.629711663109;8237.752867413987;8240.846281520711;8354.373421993254;10621.522031508446;11409.144314176636;11413.60052398162;11436.256643318158;11669.591564295548 06:16:38 INFO - PROCESS | 2002 | |3;mootools.html;1463.1659953826318;1526.7480865657171;1809.7647305850237;1952.5997170580024;1969.5765410436754;8009.078955920071;8566.614502347395;8599.699010534618;8842.823143537125;8853.114688531145;8573.485590864553;8634.827303453927;8710.303175745941;8719.607617657204;8726.86909696355;2403.0507949360035;2420.7942324902406;2424.2848359733835;2429.2712186344115;2429.651543393416;2385.809135269183;2401.8438801477937;2414.8551086934754;2421.9757802421927;2424.733279339271;2048.201201531404;2409.1929203716777;2426.2842461473906;2439.329184474275;2440.9389765255924;2349.835511514195;2363.95272094558;2364.775346342103;2383.165891937825;2405.326508577601;2387.331547166796;2419.709634843812;2430.927072187837;2449.326435230308;2457.9676535854983;8736.820529228537;8873.201411872962;8879.200871921494;8906.643734250621;8912.688055918077;5191.844244672666;5384.165454354581;5387.488188622075;5389.676619402849;5415.864603384907;3495.405781017233;3554.3246783111385;3591.3356029134693;3619.7104231661406;3625.5105560749225;1016.4968340671342;1029.526417847791;1038.2991480750538;1040.588967357897;1049.0925349572642;9851.655192068243;10578.471076446147;11150.386728729916;11690.298582085103;11698.649040528713;3957.159920636918;4295.548967358445;4595.126925884071;4848.757562121879;4868.513148685103;9912.504374781232;9963.003699629979;9978.800423991624;9988;10024.949875250577;5344.786208551614;5359.22291267764;5369.1140961740875;5385.542228910586;5386.434424385383;3806.276807406584;4701.600363969101;4721.8667519795;4775.331453596499;4859.198232291703;3986.1031267964477;4001.979990100031;4104.076582768853;4111.424400583921;4142.565030671796;1345.132389608697;1359.6396954806985;1361.5642994241748;1363.1548439967285;1363.8772510474105;701.260170520096;853.5518852602434;882.5410786391041;903.643060990918;904.1455824246025;5639;5658.830235092953;5827.533797296291;5865.912011319833;5911.527077833763;794.582844006901;963.3449254506862;982.6757170133839;986.0713680369435;998.9200863930868;3793.468914351993;3866.516685414323;3902.23906338267;3976.3439032559304;3979.5275747972855;10540.894591054144;10878.347299162075;10906.072983796466;10961.890381096087;11023.897610239072;10544.472776361305;10786.838197427045;10828;10841.620543280947;10891.237613367146;7510.962445187848;8131.146229645802;8292.502449853027;8332.666773316361;8359.122292159236;5632.042552766122;5677.5457963362005;5708.200851880657;5740.942590574208;5838.883222335445;9979.351342162736;10010.249231307535;10010.8498372523;10107.989201079834;10187.43969081678;9863.556139973574;10244.231682623982;10257.84613230817;10286.199915014991;10408.427536485264;5866.941330586639;6401.7119229633845;6759.459243260626;6949.548279361826;7026.402755765817;8245.505269683837;8272.503649781032;8277.130901255281;8378.49729016261;8414.410991230556;6272.247330320391;7216.7834964951135;7295.671694773641;7445.664945077593;7463.776086717407;7198.4601154914635;7202.063731714844;7253.56478611285;7273.163586187656;7365.410767138723;6817.829554261183;6886.208086069965;6905.516613837184;6915.412189963909;6917.723291068301;4725.881852953704;4746.406699162605;4761.76191190446;4843.2735089735415;4963.875903102451;4304.526502084831;4755.952440475551;4774.856754297377;4798.5441383068555;4885.731284779229 06:16:38 INFO - PROCESS | 2002 | |4;prototype.html;312.2957730318132;319.8784461904477;328.30235749033307;329.5929527034113;330.75524112156995;5702.317816244207;6153.692315384235;6254.624722516646;6280.811575652732;6298.307186209513;5477.068898287291;6303.117563541096;6307.873842523147;6329.1772069631;6338.207724034496;4418.762746431004;4554.8861278467975;4654.232051711463;4667.592657360129;4690.624750019991;3340.9498857517156;3711.740178187528;4122.793860306972;4598.4711758147905;4692.530746925314;4066.2680717470844;4083.3466645336753;4499.470180138752;4541.568550987651;4550;4007.2586571484367;4130.793460326987;4606.239970404879;4611.953880461186;4611.985363220087;2707.4855777402427;3891.591382904811;3907.4920260366252;3907.6127974568903;3920.980395098035;5393.6763794172475;5479.876625291846;5948.524118070544;5986.910196347058;6068;4959.553640172366;5346.812861549866;5356.625036247464;5358.544523715489;5438.211459338413;5576.665400076008;5675.290588676416;6202.790455861109;6629.436497897685;6669.666516674195;3492.3189977954307;4333.913321733579;4353.564643535653;4361.3457981302745;4477.529859364752;6760.459163266976;6913.5506192097355;6947.40947019504;6997.580145191305;7038.788836334918;4098.631123198927;4323.416338794285;4384.978075109604;4393.340998850198;4420.049689316812;3743.2139250757646;3774.679152272088;3826;4104.589541045872;4454.663600919711;4510.503844577094;5317.654352467077;5349.919751203735;5357.249985002103;5358.678479291255;4628.421447319085;5698.971505142447;5904.852378690567;6397.616143031433;6699.933000670028;1536.5159974607964;1540.9213550514685;1547.334646102187;1551.3794482207206;1557.7196104701036;856.6787454704486;961.5865177973399;989.9059589339146;999.1307562420741;1006.8187726209206;5445.50990410865;5781.335146458211;6210.534209934273;6256.186695729617;6260.718267677966;6166.784162554379;6456.319168602726;6677.23211830636;6738.056672065817;6874.931250687429;5879.970600147058;5965.433283838029;5998.431717269583;6187.443130118311;6222.844428889223;3647.2705458908326;3659.652333028358;3662.1027848176836;3682.7790332579593;3705.221903400316;5792.652440853562;6260.467860231931;6962.895556566656;7265.745698900619;7293.380062694624;5665.66006039639;5859.091840764689;6231.501479881598;7146.356827885411;7163.776300664722;5947.821565353132;6303.338149494329;6391.936080639227;7181.461390395742;7249.166345870292;6360.650164241011;6896.827579310558;6963.408110310477;6984.266652001466;6994.615296158557;5755.453231943126;6813.148356455443;6883.965580172067;6887.6556172190185;6897.862042759017;5818.650880947157;7244.631246470417;7266.346028857428;7297.963510182415;7307.671154798153;3774.9241466182007;3857.556381016107;3922.156736301709;4425.955740442683;4428.402165707588;5601;5633.267675202197;6609.735610575523;6945.853934100816;6960.825979350557;6050.697465126814;6575.63833989116;6745.662716864039;6748.493862960199;6839.31606839332;5758.942410575841;5941.643501389757;6698.698558564974;6716.328367163244;6746.35909588608;5786.537077033743;6008.24896887889;6534.607923524603;6546.541742078009;6624.9337506624315;6607;6682.832929176615;6751.898721519083;6758.594484330956;6768.2216545097945;5592.217089607377;5854.912176317273;6134.8159555213415;6331.778387756406;6560.606363618198 06:16:38 INFO - PROCESS | 2002 | |5;yui.html;722.8518153778476;730.7917243585579;737.7565403416872;737.8155461134717;761.5316580303112;15248.69502609947;16952.4066657667;17142.314307427718;17162.914185429072;17199.742003869935;15875.682486350266;15889.682206355867;15892.046477211376;15963.52109436716;16002.5999350016;718.6514540447879;912.5346073502528;925.7454200094977;933.9066093390675;940.111594543157;900.4012331799346;911.5761171055458;912.5574096563162;922.4972390047407;926.6015613286285;974.6491263145263;976.843705007199;977.1694060048937;977.4477420257567;977.4819345746765;964.6575465709677;967.8596603492524;970.2868391732071;971.0241207586366;971.659919028338;599.8350453625244;716.6237725194262;726.7020521586177;730.989035164473;731.6012773038707;15118.924405377902;15359.692806143814;15710.68578628421;15768.211589420484;15858.682826343409;12711.936440317832;12739;12780.680482987907;12810.23138611677;13118.147320424141;9903.900960990442;10089.747756306078;10178.491075446273;10212.183025357954;10620.203484738675;3396.2698019925588;3437.432823584106;3440.1055725511296;3460.3079384123025;3530.258645684409;79079.62761117176;87508;90529.54735226282;90986.5450672749;93648.0635193653;7855;9416.43501389905;9435.292353073546;9467.479288639053;9522.666706665234;21522.354329370144;21909.233176839054;22315;22471.213507527158;22507.32478025662;7538.962305188548;7572.962135189288;7606.163322034572;7658.885116723253;7679.2704693054075;3658.725595580342;3997.6801855851463;3998.3202855514633;4048.6963477739287;4048.9797551012643;3302.2239773653173;3649.033006253345;3651;3652.4886515887797;3706.3328600852105;534.6978956889345;622.3061286665336;627.8681476889813;645.7320212112015;649.1074772188241;510.56346823466146;547.479894100598;581.224065872057;606.5905513778271;611.248164757351;6886.345797149263;7661;7821.960890195513;8005.39959503028;8018.959905200437;497.2789455289772;533.5171669638983;592.2626330218819;613.7790395457631;626.4643729611208;3718.925621487555;3770.8680196193;3805.2579746949077;3903.0632648164237;3925.7448265862627;77607;95155.52422237844;96641;98231;102279;87132.56433717792;88694.4609708182;89512;89569;89695.55152224327;53244.935101298535;75222.62388688022;78254.82617760738;78925;79430.60284698539;5979.940200598112;7433.070866141732;7657.617119144132;7730.652120654471;7781.221877812173;32356;40408.58569950038;42294;45084;47059.764701176275;47339.76330118327;56342.71828640831;58197.127043095235;61478.69260653668;65381;10842.78314433691;10842.783144337227;10895.346279223271;11239.943800280946;11244.718882028015;11356.488957997075;11596.304221746384;11607;11726.824097638713;12025.699357516132;9079.038176049877;9084.591193396445;9153.588088535898;9361.719148425558;10462.529186186792;10116.544755486168;10933.398663073289;11225.101991840796;11542.538298467967;11727;11018.944905275423;11256.7748645025;11446.370449625017;11564.074874009892;11658.300501969909;9255.444673319622;9299.953500232727;9355.25157987373;9695.369800962915;9768.316217864965;8142.796430089058;9296.362076190846;9542.379745316532;10041.246906481896;10045 06:16:38 INFO - PROCESS | 2002 | __end_tp_report 06:16:38 INFO - PROCESS | 2002 | __start_cc_report 06:16:38 INFO - PROCESS | 2002 | _x_x_mozilla_cycle_collect,403 06:16:38 INFO - PROCESS | 2002 | __end_cc_report 06:16:38 INFO - PROCESS | 2002 | __startTimestamp1461330998312__endTimestamp 06:16:38 INFO - PROCESS | 2002 | 06:16:38 INFO - PROCESS | 2002 | ------- Summary: start ------- 06:16:38 INFO - PROCESS | 2002 | Number of tests: 6 06:16:38 INFO - PROCESS | 2002 | 06:16:38 INFO - PROCESS | 2002 | [#0] dojo.html Cycles:165 Average:5737.78 Median:6001.82 stddev:779.98 (13.0%) stddev-sans-first:759.62 06:16:38 INFO - PROCESS | 2002 | Values: 3354.2 3438.7 3478.3 3490.2 3545.5 5779.7 5806.6 5809.7 5836.5 5851.0 5599.4 5792.6 5811.4 5854.6 5965.3 5163.4 5249.8 5259.4 5276.3 5319.5 318.8 5148.2 5234.1 5270.7 5302.3 5172.7 5218.8 5237.1 5240.8 5280.9 5135.3 5275.7 5292.7 5306.2 5313.9 5191.2 5192.1 5205.4 5264.2 5308.7 5646.4 5718.3 5719.5 5775.7 5816.9 6125.7 6161.4 6184.4 6231.9 6277.2 6202.3 6243.4 6251.8 6263.9 6269.4 5947.6 5955.9 5960.8 5989.2 6001.8 6174.9 6233.1 6257.8 6335.7 6338.3 6221.1 6227.0 6243.5 6253.5 6255.6 6175.5 6195.7 6236.1 6248.1 6251.1 6098.8 6132.2 6213.7 6251.6 6269.6 6112.3 6160.5 6253.3 6255.4 6261.3 4883.6 4961.8 4962.2 4978.2 4997.0 3706.7 4404.9 4440.9 4487.2 4524.4 4348.4 5609.8 5753.8 5862.3 5870.3 6232.6 6249.2 6254.0 6275.7 6310.2 4965.1 5810.8 5868.4 5948.1 5972.9 4808.4 5527.7 5531.3 5536.2 5541.8 6236.0 6428.1 6450.3 6465.7 6468.9 6144.7 6194.3 6205.4 6208.9 6209.1 6419.8 6443.1 6449.5 6453.2 6470.8 5570.7 5808.4 6105.2 6168.0 6169.8 5706.3 6145.6 6205.9 6206.6 6210.1 5722.6 6165.9 6191.1 6200.6 6214.5 6120.5 6135.5 6142.9 6186.0 6215.2 5834.1 5972.8 5987.5 6063.2 6110.3 6133.4 6167.9 6170.2 6195.6 6200.3 5956.9 6039.1 6075.3 6123.9 6248.5 06:16:38 INFO - PROCESS | 2002 | 06:16:38 INFO - PROCESS | 2002 | [#1] ext.html Cycles:180 Average:68185.57 Median:38093.81 stddev:150191.94 (394.3%) stddev-sans-first:150527.39 06:16:38 INFO - PROCESS | 2002 | Values: 541.1 556.5 563.6 613.3 620.5 37086.5 37869.5 37963.9 37966.8 38105.8 39265.0 39783.2 39863.0 39984.8 40102.0 9240.8 9440.4 9485.1 9492.9 9532.4 9342.6 9436.5 9533.9 9547.6 9556.0 9540.4 9573.5 9588.3 9606.8 9607.6 9478.7 9500.2 9537.1 9548.5 9592.8 9332.8 9413.2 9450.7 9481.5 9488.1 30974.8 32350.5 38081.8 38503.2 38636.8 2522.4 2811.6 3083.4 3408.4 3426.0 25537.7 25707.5 25788.5 27107.5 27614.9 2636.3 2738.2 2748.8 2752.4 2770.6 284351.0 427004.0 507970.0 516425.0 517819.0 58906.5 59033.4 59411.5 59446.7 59513.4 61054.7 62026.4 62250.7 67562.7 69520.7 16740.8 16914.2 16995.7 17047.9 17058.7 12572.2 12604.7 12956.7 13066.3 13081.5 15921.2 18267.4 18979.8 19268.6 19359.6 8136.6 8343.6 8392.2 8394.3 8399.0 917.5 988.7 992.9 1005.5 1086.3 28204.0 29614.0 29897.0 29943.4 30191.8 981.6 1077.3 1112.6 1149.6 1249.5 13003.1 13437.3 14396.5 14532.8 14787.6 625909.0 632459.8 635330.0 635984.0 638637.0 58242.7 58856.1 59734.7 59800.0 60151.4 1369.7 1399.9 1486.1 1488.4 1493.7 23756.4 27924.8 28079.0 28628.4 28648.6 45322.0 45469.3 46090.5 46142.1 46233.3 572642.0 576111.0 577196.0 577624.0 578278.0 26598.7 37886.8 40485.8 41767.8 41865.4 41885.4 42739.8 42760.4 42839.4 43174.0 33660.2 34685.7 35854.0 36249.0 36341.8 29227.7 30840.0 35835.5 36032.6 36258.0 36160.9 36239.1 36313.6 36739.3 36827.0 27244.9 29022.7 30655.5 31576.0 32610.3 24034.0 24143.9 24434.3 24506.0 24618.8 06:16:38 INFO - PROCESS | 2002 | 06:16:38 INFO - PROCESS | 2002 | [#2] jquery.html Cycles:180 Average:33887.44 Median:11574.22 stddev:98570.15 (851.6%) stddev-sans-first:98814.58 06:16:38 INFO - PROCESS | 2002 | Values: 392.3 392.6 393.8 400.1 406.4 13344.9 19553.1 19811.5 20212.8 20277.4 19605.9 19656.7 19997.1 21045.5 21250.5 5697.9 5753.4 5875.2 5930.6 5942.3 5843.6 5882.9 5907.6 5908.6 5918.0 5597.7 5778.7 5790.4 5839.1 5842.9 5539.1 5782.4 5814.9 5817.7 5835.7 5091.8 5110.5 5127.4 5146.9 5167.1 20039.0 25030.6 25774.8 26186.6 26339.9 2103.0 2203.0 2341.7 2390.1 2534.8 14729.0 14944.6 14959.0 15325.8 15519.8 1665.9 1734.9 1760.9 1778.0 1845.2 105358.0 108358.0 108375.0 109063.8 109178.0 11020.8 11206.2 11789.8 11818.6 11995.8 14211.9 14409.1 14506.7 14581.0 14585.6 8754.1 8920.8 8930.9 8958.7 9036.7 8923.2 8949.6 8971.0 8971.9 9064.9 6858.5 6915.6 6927.3 6931.7 6959.4 1655.3 1912.8 1918.5 1936.9 1947.6 873.8 958.6 961.3 970.3 1066.9 15831.6 20523.4 20988.3 21281.4 21517.6 970.9 982.6 1029.7 1110.3 1112.8 11033.4 11298.0 11433.5 11490.6 11605.8 580764.0 588865.0 594711.0 605286.0 607111.0 101575.0 110261.0 111151.0 114295.0 114402.0 1024.8 1041.6 1052.1 1060.0 1062.5 17902.2 18673.3 18759.5 18792.9 19083.7 46993.0 47690.5 48016.5 48331.8 48536.0 65714.3 65776.0 66447.3 67107.0 68069.7 8001.8 8024.4 8106.4 8390.2 8573.0 12654.7 12738.0 12758.4 13035.2 13055.9 11014.1 11196.6 11257.0 11610.3 11676.9 10797.6 10885.6 11267.7 11385.8 11426.0 9345.6 11333.9 11405.5 11754.4 11821.0 8222.6 8228.6 8237.8 8240.8 8354.4 10621.5 11409.1 11413.6 11436.3 11669.6 06:16:38 INFO - PROCESS | 2002 | 06:16:38 INFO - PROCESS | 2002 | [#3] mootools.html Cycles:180 Average:5655.76 Median:4786.94 stddev:3163.23 (66.1%) stddev-sans-first:3156.41 06:16:38 INFO - PROCESS | 2002 | Values: 1463.2 1526.7 1809.8 1952.6 1969.6 8009.1 8566.6 8599.7 8842.8 8853.1 8573.5 8634.8 8710.3 8719.6 8726.9 2403.1 2420.8 2424.3 2429.3 2429.7 2385.8 2401.8 2414.9 2422.0 2424.7 2048.2 2409.2 2426.3 2439.3 2440.9 2349.8 2364.0 2364.8 2383.2 2405.3 2387.3 2419.7 2430.9 2449.3 2458.0 8736.8 8873.2 8879.2 8906.6 8912.7 5191.8 5384.2 5387.5 5389.7 5415.9 3495.4 3554.3 3591.3 3619.7 3625.5 1016.5 1029.5 1038.3 1040.6 1049.1 9851.7 10578.5 11150.4 11690.3 11698.6 3957.2 4295.5 4595.1 4848.8 4868.5 9912.5 9963.0 9978.8 9988.0 10024.9 5344.8 5359.2 5369.1 5385.5 5386.4 3806.3 4701.6 4721.9 4775.3 4859.2 3986.1 4002.0 4104.1 4111.4 4142.6 1345.1 1359.6 1361.6 1363.2 1363.9 701.3 853.6 882.5 903.6 904.1 5639.0 5658.8 5827.5 5865.9 5911.5 794.6 963.3 982.7 986.1 998.9 3793.5 3866.5 3902.2 3976.3 3979.5 10540.9 10878.3 10906.1 10961.9 11023.9 10544.5 10786.8 10828.0 10841.6 10891.2 7511.0 8131.1 8292.5 8332.7 8359.1 5632.0 5677.5 5708.2 5740.9 5838.9 9979.4 10010.2 10010.8 10108.0 10187.4 9863.6 10244.2 10257.8 10286.2 10408.4 5866.9 6401.7 6759.5 6949.5 7026.4 8245.5 8272.5 8277.1 8378.5 8414.4 6272.2 7216.8 7295.7 7445.7 7463.8 7198.5 7202.1 7253.6 7273.2 7365.4 6817.8 6886.2 6905.5 6915.4 6917.7 4725.9 4746.4 4761.8 4843.3 4963.9 4304.5 4756.0 4774.9 4798.5 4885.7 06:16:38 INFO - PROCESS | 2002 | 06:16:38 INFO - PROCESS | 2002 | [#4] prototype.html Cycles:180 Average:5248.43 Median:5857.00 stddev:1706.60 (29.1%) stddev-sans-first:1670.69 06:16:38 INFO - PROCESS | 2002 | Values: 312.3 319.9 328.3 329.6 330.8 5702.3 6153.7 6254.6 6280.8 6298.3 5477.1 6303.1 6307.9 6329.2 6338.2 4418.8 4554.9 4654.2 4667.6 4690.6 3340.9 3711.7 4122.8 4598.5 4692.5 4066.3 4083.3 4499.5 4541.6 4550.0 4007.3 4130.8 4606.2 4612.0 4612.0 2707.5 3891.6 3907.5 3907.6 3921.0 5393.7 5479.9 5948.5 5986.9 6068.0 4959.6 5346.8 5356.6 5358.5 5438.2 5576.7 5675.3 6202.8 6629.4 6669.7 3492.3 4333.9 4353.6 4361.3 4477.5 6760.5 6913.6 6947.4 6997.6 7038.8 4098.6 4323.4 4385.0 4393.3 4420.0 3743.2 3774.7 3826.0 4104.6 4454.7 4510.5 5317.7 5349.9 5357.2 5358.7 4628.4 5699.0 5904.9 6397.6 6699.9 1536.5 1540.9 1547.3 1551.4 1557.7 856.7 961.6 989.9 999.1 1006.8 5445.5 5781.3 6210.5 6256.2 6260.7 6166.8 6456.3 6677.2 6738.1 6874.9 5880.0 5965.4 5998.4 6187.4 6222.8 3647.3 3659.7 3662.1 3682.8 3705.2 5792.7 6260.5 6962.9 7265.7 7293.4 5665.7 5859.1 6231.5 7146.4 7163.8 5947.8 6303.3 6391.9 7181.5 7249.2 6360.7 6896.8 6963.4 6984.3 6994.6 5755.5 6813.1 6884.0 6887.7 6897.9 5818.7 7244.6 7266.3 7298.0 7307.7 3774.9 3857.6 3922.2 4426.0 4428.4 5601.0 5633.3 6609.7 6945.9 6960.8 6050.7 6575.6 6745.7 6748.5 6839.3 5758.9 5941.6 6698.7 6716.3 6746.4 5786.5 6008.2 6534.6 6546.5 6624.9 6607.0 6682.8 6751.9 6758.6 6768.2 5592.2 5854.9 6134.8 6331.8 6560.6 06:16:38 INFO - PROCESS | 2002 | 06:16:38 INFO - PROCESS | 2002 | [#5] yui.html Cycles:180 Average:18440.75 Median:603.21 stddev:26729.82 (4431.2%) stddev-sans-first:26771.70 06:16:38 INFO - PROCESS | 2002 | Values: 722.9 730.8 737.8 737.8 761.5 15248.7 16952.4 17142.3 17162.9 17199.7 15875.7 15889.7 15892.0 15963.5 16002.6 718.7 912.5 925.7 933.9 940.1 900.4 911.6 912.6 922.5 926.6 974.6 976.8 977.2 977.4 977.5 964.7 967.9 970.3 971.0 971.7 599.8 716.6 726.7 731.0 731.6 15118.9 15359.7 15710.7 15768.2 15858.7 12711.9 12739.0 12780.7 12810.2 13118.1 9903.9 10089.7 10178.5 10212.2 10620.2 3396.3 3437.4 3440.1 3460.3 3530.3 79079.6 87508.0 90529.5 90986.5 93648.1 7855.0 9416.4 9435.3 9467.5 9522.7 21522.4 21909.2 22315.0 22471.2 22507.3 7539.0 7573.0 7606.2 7658.9 7679.3 3658.7 3997.7 3998.3 4048.7 4049.0 3302.2 3649.0 3651.0 3652.5 3706.3 534.7 622.3 627.9 645.7 649.1 510.6 547.5 581.2 606.6 611.2 6886.3 7661.0 7822.0 8005.4 8019.0 497.3 533.5 592.3 613.8 626.5 3718.9 3770.9 3805.3 3903.1 3925.7 77607.0 95155.5 96641.0 98231.0 102279.0 87132.6 88694.5 89512.0 89569.0 89695.6 53244.9 75222.6 78254.8 78925.0 79430.6 5979.9 7433.1 7657.6 7730.7 7781.2 32356.0 40408.6 42294.0 45084.0 47059.8 47339.8 56342.7 58197.1 61478.7 65381.0 10842.8 10842.8 10895.3 11239.9 11244.7 11356.5 11596.3 11607.0 11726.8 12025.7 9079.0 9084.6 9153.6 9361.7 10462.5 10116.5 10933.4 11225.1 11542.5 11727.0 11018.9 11256.8 11446.4 11564.1 11658.3 9255.4 9300.0 9355.3 9695.4 9768.3 8142.8 9296.4 9542.4 10041.2 10045.0 06:16:38 INFO - PROCESS | 2002 | -------- Summary: end -------- 06:16:38 INFO - PROCESS | 2002 | 06:16:38 INFO - TEST-INFO | 2002: exit 0 06:16:38 INFO - TEST-OK | dromaeo_css | took 1112219ms 06:16:38 INFO - TEST-START | kraken 06:16:38 INFO - operating with platform_type : mac_ 06:16:38 INFO - Initialising browser for kraken test... 06:16:38 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpXwDT2_/profile http://localhost:52965/getInfo.html) 06:16:41 INFO - PROCESS | 2008 | __metrics Screen width/height:1600/1200 06:16:41 INFO - PROCESS | 2008 | colorDepth:24 06:16:41 INFO - PROCESS | 2008 | Browser inner width/height: 1024/689 06:16:41 INFO - PROCESS | 2008 | __metrics 06:16:41 ERROR - PROCESS | 2008 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:16:42 INFO - TEST-INFO | 2008: exit 0 06:16:42 INFO - Browser initialized. 06:16:42 INFO - Running cycle 1/1 for kraken test... 06:16:42 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpXwDT2_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:54 INFO - PROCESS | 2011 | RSS: Main: 247902208 06:16:54 INFO - PROCESS | 2011 | 06:16:56 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52965/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:57 INFO - PROCESS | 2011 | RSS: Main: 259907584 06:16:57 INFO - PROCESS | 2011 | 06:17:00 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52965/tests/kraken/driver.html?testName=audio-dft) 06:17:01 INFO - PROCESS | 2011 | RSS: Main: 268759040 06:17:01 INFO - PROCESS | 2011 | 06:17:04 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52965/tests/kraken/driver.html?testName=audio-fft) 06:17:05 INFO - PROCESS | 2011 | RSS: Main: 272019456 06:17:05 INFO - PROCESS | 2011 | 06:17:07 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52965/tests/kraken/driver.html?testName=audio-oscillator) 06:17:07 INFO - PROCESS | 2011 | RSS: Main: 273858560 06:17:07 INFO - PROCESS | 2011 | 06:17:09 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52965/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:17:10 INFO - PROCESS | 2011 | RSS: Main: 275271680 06:17:10 INFO - PROCESS | 2011 | 06:17:13 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52965/tests/kraken/driver.html?testName=imaging-darkroom) 06:17:13 INFO - PROCESS | 2011 | RSS: Main: 275050496 06:17:13 INFO - PROCESS | 2011 | 06:17:16 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52965/tests/kraken/driver.html?testName=imaging-desaturate) 06:17:17 INFO - PROCESS | 2011 | RSS: Main: 275095552 06:17:17 INFO - PROCESS | 2011 | 06:17:20 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52965/tests/kraken/driver.html?testName=json-parse-financial) 06:17:20 INFO - PROCESS | 2011 | RSS: Main: 275034112 06:17:20 INFO - PROCESS | 2011 | 06:17:22 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52965/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:23 INFO - PROCESS | 2011 | RSS: Main: 274976768 06:17:23 INFO - PROCESS | 2011 | 06:17:25 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:25 INFO - PROCESS | 2011 | RSS: Main: 275066880 06:17:25 INFO - PROCESS | 2011 | 06:17:27 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:17:28 INFO - PROCESS | 2011 | RSS: Main: 275304448 06:17:28 INFO - PROCESS | 2011 | 06:17:31 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:32 INFO - PROCESS | 2011 | RSS: Main: 275447808 06:17:32 INFO - PROCESS | 2011 | 06:17:35 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:35 INFO - PROCESS | 2011 | RSS: Main: 275468288 06:17:35 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:52965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52965/tests/kraken/driver.html?testName=ai-astar) 06:17:37 INFO - PROCESS | 2011 | RSS: Main: 277266432 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | __start_tp_report 06:17:37 INFO - PROCESS | 2011 | _x_x_mozilla_page_load 06:17:37 INFO - PROCESS | 2011 | _x_x_mozilla_page_load_details 06:17:37 INFO - PROCESS | 2011 | |i|pagename|runs| 06:17:37 INFO - PROCESS | 2011 | |0;ai-astar;116;109;114;115;114;127;116;117;116;115 06:17:37 INFO - PROCESS | 2011 | |1;audio-beat-detection;167;124;155;197;123;156;157;172;162;123 06:17:37 INFO - PROCESS | 2011 | |2;audio-dft;201;198;207;242;244;205;199;198;203;237 06:17:37 INFO - PROCESS | 2011 | |3;audio-fft;68;70;83;141;58;57;57;61;138;82 06:17:37 INFO - PROCESS | 2011 | |4;audio-oscillator;80;84;131;77;83;84;122;79;83;126 06:17:37 INFO - PROCESS | 2011 | |5;imaging-gaussian-blur;89;86;89;87;90;86;91;87;88;87 06:17:37 INFO - PROCESS | 2011 | |6;imaging-darkroom;94;96;96;95;100;150;95;95;95;95 06:17:37 INFO - PROCESS | 2011 | |7;imaging-desaturate;92;91;90;91;93;90;89;92;91;91 06:17:37 INFO - PROCESS | 2011 | |8;json-parse-financial;62;62;63;63;63;62;61;81;64;60 06:17:37 INFO - PROCESS | 2011 | |9;json-stringify-tinderbox;83;89;59;101;61;87;105;101;97;76 06:17:37 INFO - PROCESS | 2011 | |10;stanford-crypto-aes;88;86;84;83;85;84;83;89;84;84 06:17:37 INFO - PROCESS | 2011 | |11;stanford-crypto-ccm;141;142;139;167;165;163;137;142;168;174 06:17:37 INFO - PROCESS | 2011 | |12;stanford-crypto-pbkdf2;177;176;172;183;210;170;173;174;171;172 06:17:37 INFO - PROCESS | 2011 | |13;stanford-crypto-sha256-iterative;71;66;98;101;104;100;59;82;105;95 06:17:37 INFO - PROCESS | 2011 | __end_tp_report 06:17:37 INFO - PROCESS | 2011 | __start_cc_report 06:17:37 INFO - PROCESS | 2011 | _x_x_mozilla_cycle_collect,1032 06:17:37 INFO - PROCESS | 2011 | __end_cc_report 06:17:37 INFO - PROCESS | 2011 | __startTimestamp1461331057913__endTimestamp 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | ------- Summary: start ------- 06:17:37 INFO - PROCESS | 2011 | Number of tests: 14 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.00 stddev:4.48 (3.9%) stddev-sans-first:4.76 06:17:37 INFO - PROCESS | 2011 | Values: 116.0 109.0 114.0 115.0 114.0 127.0 116.0 117.0 116.0 115.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:159.50 stddev:24.13 (15.1%) stddev-sans-first:25.10 06:17:37 INFO - PROCESS | 2011 | Values: 167.0 124.0 155.0 197.0 123.0 156.0 157.0 172.0 162.0 123.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#2] audio-dft Cycles:10 Average:213.40 Median:206.00 stddev:19.34 (9.4%) stddev-sans-first:19.99 06:17:37 INFO - PROCESS | 2011 | Values: 201.0 198.0 207.0 242.0 244.0 205.0 199.0 198.0 203.0 237.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#3] audio-fft Cycles:10 Average:81.50 Median:64.50 stddev:32.01 (49.6%) stddev-sans-first:33.58 06:17:37 INFO - PROCESS | 2011 | Values: 68.0 70.0 83.0 141.0 58.0 57.0 57.0 61.0 138.0 82.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:81.50 stddev:21.91 (26.9%) stddev-sans-first:22.57 06:17:37 INFO - PROCESS | 2011 | Values: 80.0 84.0 131.0 77.0 83.0 84.0 122.0 79.0 83.0 126.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.50 stddev:1.70 (1.9%) stddev-sans-first:1.76 06:17:37 INFO - PROCESS | 2011 | Values: 89.0 86.0 89.0 87.0 90.0 86.0 91.0 87.0 88.0 87.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#6] imaging-darkroom Cycles:10 Average:101.10 Median:95.00 stddev:17.26 (18.2%) stddev-sans-first:18.11 06:17:37 INFO - PROCESS | 2011 | Values: 94.0 96.0 96.0 95.0 100.0 150.0 95.0 95.0 95.0 95.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#7] imaging-desaturate Cycles:10 Average:91.00 Median:91.00 stddev:1.15 (1.3%) stddev-sans-first:1.17 06:17:37 INFO - PROCESS | 2011 | Values: 92.0 91.0 90.0 91.0 93.0 90.0 89.0 92.0 91.0 91.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:63.00 stddev:6.05 (9.6%) stddev-sans-first:6.36 06:17:37 INFO - PROCESS | 2011 | Values: 62.0 62.0 63.0 63.0 63.0 62.0 61.0 81.0 64.0 60.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#9] json-stringify-tinderbox Cycles:10 Average:85.90 Median:79.50 stddev:16.35 (20.6%) stddev-sans-first:17.30 06:17:37 INFO - PROCESS | 2011 | Values: 83.0 89.0 59.0 101.0 61.0 87.0 105.0 101.0 97.0 76.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:2.05 (2.4%) stddev-sans-first:1.87 06:17:37 INFO - PROCESS | 2011 | Values: 88.0 86.0 84.0 83.0 85.0 84.0 83.0 89.0 84.0 84.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:164.00 stddev:14.67 (8.9%) stddev-sans-first:14.81 06:17:37 INFO - PROCESS | 2011 | Values: 141.0 142.0 139.0 167.0 165.0 163.0 137.0 142.0 168.0 174.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.80 Median:175.00 stddev:11.92 (6.8%) stddev-sans-first:12.64 06:17:37 INFO - PROCESS | 2011 | Values: 177.0 176.0 172.0 183.0 210.0 170.0 173.0 174.0 171.0 172.0 06:17:37 INFO - PROCESS | 2011 | 06:17:37 INFO - PROCESS | 2011 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.10 Median:68.50 stddev:17.18 (25.1%) stddev-sans-first:17.07 06:17:37 INFO - PROCESS | 2011 | Values: 71.0 66.0 98.0 101.0 104.0 100.0 59.0 82.0 105.0 95.0 06:17:37 INFO - PROCESS | 2011 | -------- Summary: end -------- 06:17:37 INFO - PROCESS | 2011 | 06:17:38 INFO - TEST-INFO | 2011: exit 0 06:17:38 INFO - TEST-OK | kraken | took 59829ms 06:17:38 INFO - SUITE-END | took 1172s 06:17:39 INFO - Completed test suite (00:19:32) 06:17:39 INFO - javascript benchmark 06:17:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3354.2452948086675, 3438.656134386561, 3478.2521757822065, 3490.2147016921194, 3545.5036294918714, 5779.653220806749, 5806.564507661927, 5809.651420914748, 5836.503897168745, 5851.0, 5599.384067752544, 5792.594518383704, 5811.418858114186, 5854.560907931901, 5965.284165900098, 5163.380394352674, 5249.763760630762, 5259.447757985414, 5276.287701160332, 5319.547838433718, 318.7811839459988, 5148.150555158413, 5234.0840352938085, 5270.657407268515, 5302.284191634138, 5172.663776854492, 5218.791248350061, 5237.13587258102, 5240.816571420001, 5280.947190528084, 5135.281060651474, 5275.709835959021, 5292.735363231862, 5306.204069389584, 5313.867153321159, 5191.195364718475, 5192.091384007821, 5205.427402985669, 5264.184051472028, 5308.734563271821, 5646.435356464362, 5718.256626638552, 5719.48524632785, 5775.711214439261, 5816.8836623267725, 6125.662799505643, 6161.4146656067605, 6184.412480814315, 6231.906521402183, 6277.2153480814895, 6202.286737025254, 6243.438090571825, 6251.812445626639, 6263.906041409383, 6269.3730626937395, 5947.553933454921, 5955.851103722398, 5960.791372301992, 5989.221401217857, 6001.819945401601, 6174.938250617436, 6233.1273621693, 6257.843553911098, 6335.651539165298, 6338.334474880164, 6221.09794079865, 6226.968865155645, 6243.500519958392, 6253.499720022387, 6255.562110652301, 6175.505959523227, 6195.659238741822, 6236.064590311489, 6248.062790581449, 6251.062340648939, 6098.847528811815, 6132.171952247653, 6213.689315534205, 6251.59364641306, 6269.62382257066, 6112.290716697417, 6160.537959653044, 6253.312135665074, 6255.43701066897, 6261.342559031327, 4883.633727470454, 4961.776720047606, 4962.230854217602, 4978.228374601942, 4997.025580011936, 3706.7405281630026, 4404.867853964386, 4440.933385999213, 4487.192305384997, 4524.366588677588, 4348.391225228471, 5609.803656872072, 5753.827385178452, 5862.325832529228, 5870.324912635102, 6232.594881332699, 6249.156363890907, 6253.999360102362, 6275.6862156891975, 6310.242770867433, 4965.0566392385335, 5810.779736255434, 5868.38381969887, 5948.10778383246, 5972.910406343908, 4808.374911261513, 5527.723613819293, 5531.3362396511875, 5536.197251398525, 5541.750621222055, 6236.0, 6428.100065990765, 6450.290468048604, 6465.676716164267, 6468.935310646927, 6144.678894037804, 6194.287656919512, 6205.441510264098, 6208.875822483616, 6209.0996805462055, 6419.8395040122505, 6443.130177426175, 6449.5485316027425, 6453.225612926291, 6470.773522926675, 5570.6657600544095, 5808.36108028125, 6105.206323177958, 6167.969160154171, 6169.81490555284, 5706.343770466449, 6145.617236121837, 6205.937940620536, 6206.596571222856, 6210.099535567408, 5722.62802917809, 6165.938340616716, 6191.133241346305, 6200.627962322275, 6214.533909956862, 6120.510359171167, 6135.477655820289, 6142.877142457215, 6186.0, 6215.223097112861, 5834.095715164156, 5972.820815375546, 5987.520998320211, 6063.211782468251, 6110.3461303294, 6133.417325354084, 6167.876642467215, 6170.197874276315, 6195.566310358232, 6200.255969283715, 5956.910646340395, 6039.124326972476, 6075.270967483753, 6123.877522449437, 6248.531360148098], "value": 5690.510997157781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.0585581088906, 556.5436342199398, 563.6280055163592, 613.3069631316612, 620.5004970998348, 37086.51653933843, 37869.48522059121, 37963.86108416748, 37966.81016594913, 38105.80947095268, 39265.0, 39783.204335913266, 39863.003424914394, 39984.80007599958, 40102.0, 9240.768980775467, 9440.386374885646, 9485.146336829685, 9492.905070949306, 9532.380395274286, 9342.626294948228, 9436.528173591327, 9533.856992145124, 9547.61809527618, 9555.952220238889, 9540.427574345562, 9573.473458959754, 9588.328816982814, 9606.75983100421, 9607.615695372177, 9478.71563853082, 9500.23998080152, 9537.14165725088, 9548.474833884133, 9592.808143837085, 9332.766680833034, 9413.152816246502, 9450.669226577105, 9481.525923703855, 9488.051194880525, 30974.845125774453, 32350.514742278883, 38081.80959095214, 38503.22993540142, 38636.80681596602, 2522.445062086338, 2811.5923191137376, 3083.3833233353193, 3408.3694516514524, 3425.9657403425895, 25537.723113844233, 25707.485850283076, 25788.484230315476, 27107.45785084287, 27614.861925690442, 2636.2618466829317, 2738.192233291184, 2748.7938404619736, 2752.4357506711276, 2770.612114303999, 284351.0, 427004.0, 507970.0, 516425.0, 517819.0, 58906.52733681606, 59033.40966590279, 59411.51471213254, 59446.70276648589, 59513.40486595079, 61054.69472652697, 62026.37973620206, 62250.68874655688, 67562.66218668876, 69520.6523967377, 16740.83259167417, 16914.238859251363, 16995.74506382405, 17047.91476042612, 17058.658826823394, 12572.245665260114, 12604.747905042032, 12956.676083097998, 13066.34668266583, 13081.542146024844, 15921.203939802963, 18267.36064237772, 18979.81020189808, 19268.614627707368, 19359.612807743768, 8136.616775148239, 8343.582820858932, 8392.244697977088, 8394.286485648667, 8399.0, 917.5366439947917, 988.7478692933256, 992.8609994600762, 1005.4872015272117, 1086.3156211586809, 28204.012859549817, 29614.0, 29897.0, 29943.42967551747, 30191.849040754656, 981.6220755009373, 1077.3320541264309, 1112.6383925224334, 1149.5746573767592, 1249.4814651919532, 13003.052664711504, 13437.260950647613, 14396.496122635657, 14532.782008269884, 14787.556373308818, 625909.0, 632459.8377008085, 635330.0, 635984.0, 638637.0, 58242.7087864558, 58856.11715824266, 59734.70132649396, 59800.0, 60151.39848601545, 1369.7465968795805, 1399.9090059146326, 1486.1009089500913, 1488.4120772294882, 1493.7161939231728, 23756.406089847893, 27924.795956084094, 28079.0, 28628.427431450837, 28648.57027144553, 45322.0, 45469.317960229964, 46090.539094608626, 46142.077158457316, 46233.29617205419, 572642.0, 576111.0, 577196.0, 577624.0, 578278.0, 26598.734012659625, 37886.81056594809, 40485.79757101196, 41767.791161044, 41865.37201941913, 41885.371719424846, 42739.78630106829, 42760.358594620484, 42839.35740963826, 43174.0, 33660.158496037795, 34685.65314346925, 35854.0, 36249.0, 36341.81829090838, 29227.70772292335, 30840.0, 35835.46246806248, 36032.63967360293, 36258.0, 36160.92632126193, 36239.094022649646, 36313.63686363103, 36739.26521469609, 36827.0, 27244.863775680995, 29022.709772902846, 30655.467226639026, 31576.0, 32610.347793044482, 24034.0, 24143.879280603483, 24434.26697199087, 24506.019759210147, 24618.753812461648], "value": 19514.62900150978, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.3291172095716, 392.59170462718777, 393.82868452223283, 400.0977795072112, 406.3701263042284, 13344.933275333635, 19553.120109595067, 19811.50471238216, 20212.797872021292, 20277.391678249656, 19605.92167430791, 19656.70514942277, 19997.100130494127, 21045.473863153427, 21250.46873828155, 5697.857553561153, 5753.395893431192, 5875.206847075654, 5930.644161350333, 5942.2869255689375, 5843.620164689303, 5882.941170588304, 5907.645541267538, 5908.556858235628, 5917.993941030035, 5597.692126933017, 5778.653280803144, 5790.449907258825, 5839.0949402842625, 5842.88314233715, 5539.086050801613, 5782.3639399666, 5814.912776308338, 5817.7091145442555, 5835.679037652927, 5091.847244582631, 5110.4634013428795, 5127.3847138343635, 5146.922796158061, 5167.069927413064, 20039.0, 25030.624540631907, 25774.840132194095, 26186.607200892002, 26339.868300658374, 2102.9684554731693, 2202.973264596575, 2341.7072865891764, 2390.091765129257, 2534.835235709673, 14729.0, 14944.62638434037, 14959.0, 15325.770113448307, 15519.767203491956, 1665.9083750393725, 1734.9392771253072, 1760.9207585658676, 1777.9555511112326, 1845.1604519943528, 105358.0, 108358.0, 108375.0, 109063.81872362508, 109178.0, 11020.779584408267, 11206.21556491054, 11789.764204715857, 11818.645440636794, 11995.820062699066, 14211.85788142126, 14409.13545187292, 14506.709865802624, 14581.0, 14585.635359115895, 8754.124587541195, 8920.776980575538, 8930.910690893008, 8958.68644597436, 9036.683716069905, 8923.15230053144, 8949.59726812282, 8970.968338641009, 8971.910280897107, 9064.864027039599, 6858.485613579001, 6915.585064896122, 6927.272636373209, 6931.7227310907, 6959.408450281681, 1655.337864854044, 1912.7704675438758, 1918.5395505078682, 1936.9225230990885, 1947.57153426246, 873.8252349530119, 958.5782255807422, 961.3414810854587, 970.277143528062, 1066.909312708413, 15831.604209894846, 20523.384298471068, 20988.26541071055, 21281.36155915325, 21517.56964860694, 970.8932017478072, 982.6364245229311, 1029.6807989523272, 1110.2838669058574, 1112.777444511101, 11033.448327583588, 11298.0, 11433.485493152828, 11490.597829075943, 11605.76788464243, 580764.0, 588865.0, 594711.0, 605286.0, 607111.0, 101575.0, 110261.0, 111151.0, 114295.0, 114402.0, 1024.8257796174669, 1041.578160844859, 1052.1267348101057, 1060.0459586372172, 1062.5377960587016, 17902.194401251716, 18673.253069877595, 18759.53101172427, 18792.906035469736, 19083.713744294124, 46993.0, 47690.52309477, 48016.5198348026, 48331.758341209475, 48536.0, 65714.34285657082, 65776.0, 66447.33552664412, 67107.0, 68069.65965170143, 8001.839963200587, 8024.438289319692, 8106.39202059836, 8390.202930721573, 8572.957135214285, 12654.746905061664, 12738.044646651724, 12758.362081896053, 13035.15271507349, 13055.934720326337, 11014.063804576701, 11196.552137914392, 11256.986871181633, 11610.303381797119, 11676.94161529187, 10797.62208322705, 10885.619003334845, 11267.661970140909, 11385.772284554429, 11426.02878755315, 9345.579448924678, 11333.886661133283, 11405.486753095965, 11754.412279386168, 11821.0, 8222.588870556328, 8228.629711663109, 8237.752867413987, 8240.846281520711, 8354.373421993254, 10621.522031508446, 11409.144314176636, 11413.60052398162, 11436.256643318158, 11669.591564295548], "value": 9695.714111975265, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.1659953826318, 1526.7480865657171, 1809.7647305850237, 1952.5997170580024, 1969.5765410436754, 8009.078955920071, 8566.614502347395, 8599.699010534618, 8842.823143537125, 8853.114688531145, 8573.485590864553, 8634.827303453927, 8710.303175745941, 8719.607617657204, 8726.86909696355, 2403.0507949360035, 2420.7942324902406, 2424.2848359733835, 2429.2712186344115, 2429.651543393416, 2385.809135269183, 2401.8438801477937, 2414.8551086934754, 2421.9757802421927, 2424.733279339271, 2048.201201531404, 2409.1929203716777, 2426.2842461473906, 2439.329184474275, 2440.9389765255924, 2349.835511514195, 2363.95272094558, 2364.775346342103, 2383.165891937825, 2405.326508577601, 2387.331547166796, 2419.709634843812, 2430.927072187837, 2449.326435230308, 2457.9676535854983, 8736.820529228537, 8873.201411872962, 8879.200871921494, 8906.643734250621, 8912.688055918077, 5191.844244672666, 5384.165454354581, 5387.488188622075, 5389.676619402849, 5415.864603384907, 3495.405781017233, 3554.3246783111385, 3591.3356029134693, 3619.7104231661406, 3625.5105560749225, 1016.4968340671342, 1029.526417847791, 1038.2991480750538, 1040.588967357897, 1049.0925349572642, 9851.655192068243, 10578.471076446147, 11150.386728729916, 11690.298582085103, 11698.649040528713, 3957.159920636918, 4295.548967358445, 4595.126925884071, 4848.757562121879, 4868.513148685103, 9912.504374781232, 9963.003699629979, 9978.800423991624, 9988.0, 10024.949875250577, 5344.786208551614, 5359.22291267764, 5369.1140961740875, 5385.542228910586, 5386.434424385383, 3806.276807406584, 4701.600363969101, 4721.8667519795, 4775.331453596499, 4859.198232291703, 3986.1031267964477, 4001.979990100031, 4104.076582768853, 4111.424400583921, 4142.565030671796, 1345.132389608697, 1359.6396954806985, 1361.5642994241748, 1363.1548439967285, 1363.8772510474105, 701.260170520096, 853.5518852602434, 882.5410786391041, 903.643060990918, 904.1455824246025, 5639.0, 5658.830235092953, 5827.533797296291, 5865.912011319833, 5911.527077833763, 794.582844006901, 963.3449254506862, 982.6757170133839, 986.0713680369435, 998.9200863930868, 3793.468914351993, 3866.516685414323, 3902.23906338267, 3976.3439032559304, 3979.5275747972855, 10540.894591054144, 10878.347299162075, 10906.072983796466, 10961.890381096087, 11023.897610239072, 10544.472776361305, 10786.838197427045, 10828.0, 10841.620543280947, 10891.237613367146, 7510.962445187848, 8131.146229645802, 8292.502449853027, 8332.666773316361, 8359.122292159236, 5632.042552766122, 5677.5457963362005, 5708.200851880657, 5740.942590574208, 5838.883222335445, 9979.351342162736, 10010.249231307535, 10010.8498372523, 10107.989201079834, 10187.43969081678, 9863.556139973574, 10244.231682623982, 10257.84613230817, 10286.199915014991, 10408.427536485264, 5866.941330586639, 6401.7119229633845, 6759.459243260626, 6949.548279361826, 7026.402755765817, 8245.505269683837, 8272.503649781032, 8277.130901255281, 8378.49729016261, 8414.410991230556, 6272.247330320391, 7216.7834964951135, 7295.671694773641, 7445.664945077593, 7463.776086717407, 7198.4601154914635, 7202.063731714844, 7253.56478611285, 7273.163586187656, 7365.410767138723, 6817.829554261183, 6886.208086069965, 6905.516613837184, 6915.412189963909, 6917.723291068301, 4725.881852953704, 4746.406699162605, 4761.76191190446, 4843.2735089735415, 4963.875903102451, 4304.526502084831, 4755.952440475551, 4774.856754297377, 4798.5441383068555, 4885.731284779229], "value": 4563.951181799705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.2957730318132, 319.8784461904477, 328.30235749033307, 329.5929527034113, 330.75524112156995, 5702.317816244207, 6153.692315384235, 6254.624722516646, 6280.811575652732, 6298.307186209513, 5477.068898287291, 6303.117563541096, 6307.873842523147, 6329.1772069631, 6338.207724034496, 4418.762746431004, 4554.8861278467975, 4654.232051711463, 4667.592657360129, 4690.624750019991, 3340.9498857517156, 3711.740178187528, 4122.793860306972, 4598.4711758147905, 4692.530746925314, 4066.2680717470844, 4083.3466645336753, 4499.470180138752, 4541.568550987651, 4550.0, 4007.2586571484367, 4130.793460326987, 4606.239970404879, 4611.953880461186, 4611.985363220087, 2707.4855777402427, 3891.591382904811, 3907.4920260366252, 3907.6127974568903, 3920.980395098035, 5393.6763794172475, 5479.876625291846, 5948.524118070544, 5986.910196347058, 6068.0, 4959.553640172366, 5346.812861549866, 5356.625036247464, 5358.544523715489, 5438.211459338413, 5576.665400076008, 5675.290588676416, 6202.790455861109, 6629.436497897685, 6669.666516674195, 3492.3189977954307, 4333.913321733579, 4353.564643535653, 4361.3457981302745, 4477.529859364752, 6760.459163266976, 6913.5506192097355, 6947.40947019504, 6997.580145191305, 7038.788836334918, 4098.631123198927, 4323.416338794285, 4384.978075109604, 4393.340998850198, 4420.049689316812, 3743.2139250757646, 3774.679152272088, 3826.0, 4104.589541045872, 4454.663600919711, 4510.503844577094, 5317.654352467077, 5349.919751203735, 5357.249985002103, 5358.678479291255, 4628.421447319085, 5698.971505142447, 5904.852378690567, 6397.616143031433, 6699.933000670028, 1536.5159974607964, 1540.9213550514685, 1547.334646102187, 1551.3794482207206, 1557.7196104701036, 856.6787454704486, 961.5865177973399, 989.9059589339146, 999.1307562420741, 1006.8187726209206, 5445.50990410865, 5781.335146458211, 6210.534209934273, 6256.186695729617, 6260.718267677966, 6166.784162554379, 6456.319168602726, 6677.23211830636, 6738.056672065817, 6874.931250687429, 5879.970600147058, 5965.433283838029, 5998.431717269583, 6187.443130118311, 6222.844428889223, 3647.2705458908326, 3659.652333028358, 3662.1027848176836, 3682.7790332579593, 3705.221903400316, 5792.652440853562, 6260.467860231931, 6962.895556566656, 7265.745698900619, 7293.380062694624, 5665.66006039639, 5859.091840764689, 6231.501479881598, 7146.356827885411, 7163.776300664722, 5947.821565353132, 6303.338149494329, 6391.936080639227, 7181.461390395742, 7249.166345870292, 6360.650164241011, 6896.827579310558, 6963.408110310477, 6984.266652001466, 6994.615296158557, 5755.453231943126, 6813.148356455443, 6883.965580172067, 6887.6556172190185, 6897.862042759017, 5818.650880947157, 7244.631246470417, 7266.346028857428, 7297.963510182415, 7307.671154798153, 3774.9241466182007, 3857.556381016107, 3922.156736301709, 4425.955740442683, 4428.402165707588, 5601.0, 5633.267675202197, 6609.735610575523, 6945.853934100816, 6960.825979350557, 6050.697465126814, 6575.63833989116, 6745.662716864039, 6748.493862960199, 6839.31606839332, 5758.942410575841, 5941.643501389757, 6698.698558564974, 6716.328367163244, 6746.35909588608, 5786.537077033743, 6008.24896887889, 6534.607923524603, 6546.541742078009, 6624.9337506624315, 6607.0, 6682.832929176615, 6751.898721519083, 6758.594484330956, 6768.2216545097945, 5592.217089607377, 5854.912176317273, 6134.8159555213415, 6331.778387756406, 6560.606363618198], "value": 4697.303075233689, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.8518153778476, 730.7917243585579, 737.7565403416872, 737.8155461134717, 761.5316580303112, 15248.69502609947, 16952.4066657667, 17142.314307427718, 17162.914185429072, 17199.742003869935, 15875.682486350266, 15889.682206355867, 15892.046477211376, 15963.52109436716, 16002.5999350016, 718.6514540447879, 912.5346073502528, 925.7454200094977, 933.9066093390675, 940.111594543157, 900.4012331799346, 911.5761171055458, 912.5574096563162, 922.4972390047407, 926.6015613286285, 974.6491263145263, 976.843705007199, 977.1694060048937, 977.4477420257567, 977.4819345746765, 964.6575465709677, 967.8596603492524, 970.2868391732071, 971.0241207586366, 971.659919028338, 599.8350453625244, 716.6237725194262, 726.7020521586177, 730.989035164473, 731.6012773038707, 15118.924405377902, 15359.692806143814, 15710.68578628421, 15768.211589420484, 15858.682826343409, 12711.936440317832, 12739.0, 12780.680482987907, 12810.23138611677, 13118.147320424141, 9903.900960990442, 10089.747756306078, 10178.491075446273, 10212.183025357954, 10620.203484738675, 3396.2698019925588, 3437.432823584106, 3440.1055725511296, 3460.3079384123025, 3530.258645684409, 79079.62761117176, 87508.0, 90529.54735226282, 90986.5450672749, 93648.0635193653, 7855.0, 9416.43501389905, 9435.292353073546, 9467.479288639053, 9522.666706665234, 21522.354329370144, 21909.233176839054, 22315.0, 22471.213507527158, 22507.32478025662, 7538.962305188548, 7572.962135189288, 7606.163322034572, 7658.885116723253, 7679.2704693054075, 3658.725595580342, 3997.6801855851463, 3998.3202855514633, 4048.6963477739287, 4048.9797551012643, 3302.2239773653173, 3649.033006253345, 3651.0, 3652.4886515887797, 3706.3328600852105, 534.6978956889345, 622.3061286665336, 627.8681476889813, 645.7320212112015, 649.1074772188241, 510.56346823466146, 547.479894100598, 581.224065872057, 606.5905513778271, 611.248164757351, 6886.345797149263, 7661.0, 7821.960890195513, 8005.39959503028, 8018.959905200437, 497.2789455289772, 533.5171669638983, 592.2626330218819, 613.7790395457631, 626.4643729611208, 3718.925621487555, 3770.8680196193, 3805.2579746949077, 3903.0632648164237, 3925.7448265862627, 77607.0, 95155.52422237844, 96641.0, 98231.0, 102279.0, 87132.56433717792, 88694.4609708182, 89512.0, 89569.0, 89695.55152224327, 53244.935101298535, 75222.62388688022, 78254.82617760738, 78925.0, 79430.60284698539, 5979.940200598112, 7433.070866141732, 7657.617119144132, 7730.652120654471, 7781.221877812173, 32356.0, 40408.58569950038, 42294.0, 45084.0, 47059.764701176275, 47339.76330118327, 56342.71828640831, 58197.127043095235, 61478.69260653668, 65381.0, 10842.78314433691, 10842.783144337227, 10895.346279223271, 11239.943800280946, 11244.718882028015, 11356.488957997075, 11596.304221746384, 11607.0, 11726.824097638713, 12025.699357516132, 9079.038176049877, 9084.591193396445, 9153.588088535898, 9361.719148425558, 10462.529186186792, 10116.544755486168, 10933.398663073289, 11225.101991840796, 11542.538298467967, 11727.0, 11018.944905275423, 11256.7748645025, 11446.370449625017, 11564.074874009892, 11658.300501969909, 9255.444673319622, 9299.953500232727, 9355.25157987373, 9695.369800962915, 9768.316217864965, 8142.796430089058, 9296.362076190846, 9542.379745316532, 10041.246906481896, 10045.0], "value": 6856.0607942723, "unit": "score"}], "name": "dromaeo_css", "value": 7354.7164856930995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 114.0, 115.0, 114.0, 127.0, 116.0, 117.0, 116.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 124.0, 155.0, 197.0, 123.0, 156.0, 157.0, 172.0, 162.0, 123.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 198.0, 207.0, 242.0, 244.0, 205.0, 199.0, 198.0, 203.0, 237.0], "value": 213.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 83.0, 141.0, 58.0, 57.0, 57.0, 61.0, 138.0, 82.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 131.0, 77.0, 83.0, 84.0, 122.0, 79.0, 83.0, 126.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 90.0, 86.0, 91.0, 87.0, 88.0, 87.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 95.0, 100.0, 150.0, 95.0, 95.0, 95.0, 95.0], "value": 101.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 90.0, 91.0, 93.0, 90.0, 89.0, 92.0, 91.0, 91.0], "value": 91.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 61.0, 81.0, 64.0, 60.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 89.0, 59.0, 101.0, 61.0, 87.0, 105.0, 101.0, 97.0, 76.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 84.0, 83.0, 85.0, 84.0, 83.0, 89.0, 84.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 139.0, 167.0, 165.0, 163.0, 137.0, 142.0, 168.0, 174.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 172.0, 183.0, 210.0, 170.0, 173.0, 174.0, 171.0, 172.0], "value": 177.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 98.0, 101.0, 104.0, 100.0, 59.0, 82.0, 105.0, 95.0], "value": 88.1, "unit": "score"}], "name": "kraken", "value": 1594.1, "alertThreshold": 2.0}]} 06:17:39 INFO - Return code: 0 06:17:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:17:39 ERROR - # TBPL SUCCESS # 06:17:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:17:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:17:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:17:39 INFO - 2016-04-22 06:17:39.214 screenresolution[2016:28616] starting screenresolution argv=screenresolution get 06:17:39 INFO - 2016-04-22 06:17:39.216 screenresolution[2016:28616] Display 0: 1600x1200x32@60 06:17:39 INFO - 2016-04-22 06:17:39.222 screenresolution[2017:28619] starting screenresolution argv=screenresolution list 06:17:39 INFO - Available Modes on Display 0 06:17:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:17:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:17:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:17:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:17:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:17:39 INFO - Intel Iris: 06:17:39 INFO - Chipset Model: Intel Iris 06:17:39 INFO - Type: GPU 06:17:39 INFO - Bus: Built-In 06:17:39 INFO - VRAM (Dynamic, Max): 1536 MB 06:17:39 INFO - Vendor: Intel (0x8086) 06:17:39 INFO - Device ID: 0x0a2e 06:17:39 INFO - Revision ID: 0x0009 06:17:39 INFO - Displays: 06:17:39 INFO - Display: 06:17:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:17:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:17:39 INFO - Display Serial Number: 1600x1200 60 06:17:39 INFO - Main Display: Yes 06:17:39 INFO - Mirror: Off 06:17:39 INFO - Online: Yes 06:17:39 INFO - Rotation: Supported 06:17:39 INFO - Return code: 0 06:17:39 INFO - Running post-action listener: _resource_record_post_action 06:17:39 INFO - Running post-run listener: _resource_record_post_run 06:17:40 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 475136; Write bytes: 694319104; Read time: 8; Write time: 2269 06:17:40 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 373174784; Write bytes: 366827008; Read time: 28245; Write time: 718 06:17:40 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 475136; Write bytes: 298103296; Read time: 8; Write time: 1495 06:17:40 INFO - Running post-run listener: _upload_blobber_files 06:17:40 INFO - Blob upload gear active. 06:17:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:17:40 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'] 06:17:40 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 06:17:40 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:17:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:17:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:41 INFO - (blobuploader) - INFO - Done attempting. 06:17:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:17:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:17:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:42 INFO - (blobuploader) - INFO - Done attempting. 06:17:42 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:42 INFO - Return code: 0 06:17:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05ca21dc8aaea9c4629732cb4a2a7b7e62dd763fa1af03daf7ec83aaf970d4edae827d4316f978f42c7fb430a13185abc8bbbedd07e0d00c1010d4a328e91bb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a77d1c80a8f406804af605010520a0d31446ef03cf0e67d5564beb6f4827f6ca38d41027ef0b6354ddacab271bd111c9ec28e6b22a0b2495f83dd977d0bb4d4"} 06:17:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:42 INFO - Contents: 06:17:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05ca21dc8aaea9c4629732cb4a2a7b7e62dd763fa1af03daf7ec83aaf970d4edae827d4316f978f42c7fb430a13185abc8bbbedd07e0d00c1010d4a328e91bb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a77d1c80a8f406804af605010520a0d31446ef03cf0e67d5564beb6f4827f6ca38d41027ef0b6354ddacab271bd111c9ec28e6b22a0b2495f83dd977d0bb4d4"} 06:17:42 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:42 INFO - Copying logs to upload dir... 06:17:42 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.743866 ========= master_lag: 5.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-22 06:17:48.347197) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 6 secs) (at 2016-04-22 06:17:48.348398) ========= 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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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/05ca21dc8aaea9c4629732cb4a2a7b7e62dd763fa1af03daf7ec83aaf970d4edae827d4316f978f42c7fb430a13185abc8bbbedd07e0d00c1010d4a328e91bb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a77d1c80a8f406804af605010520a0d31446ef03cf0e67d5564beb6f4827f6ca38d41027ef0b6354ddacab271bd111c9ec28e6b22a0b2495f83dd977d0bb4d4"} build_url:https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/bVymaqpcTomf9pB5UcmAjA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05ca21dc8aaea9c4629732cb4a2a7b7e62dd763fa1af03daf7ec83aaf970d4edae827d4316f978f42c7fb430a13185abc8bbbedd07e0d00c1010d4a328e91bb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a77d1c80a8f406804af605010520a0d31446ef03cf0e67d5564beb6f4827f6ca38d41027ef0b6354ddacab271bd111c9ec28e6b22a0b2495f83dd977d0bb4d4"}' ========= master_lag: 6.71 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 6 secs) (at 2016-04-22 06:17:55.066490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:17:55.068853) ========= 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.G6qIoYX9SX/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.skn7Gg3PwP/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005319 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:17:55.144036) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:17:55.144367) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:17:55.749462) ========= ========= Total master_lag: 12.49 =========