builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0189 starttime: 1464039276.59 results: success (0) buildid: 20160523130801 builduid: 7111702919aa4d0f925a7ba95f4d8d09 revision: ec97adea519ba55ac05a2af28534e0594b97f80e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:36.594197) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:36.594599) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:36.594862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:36.614029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:36.614307) ========= 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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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-05-23 14:34:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.25M=0.001s 2016-05-23 14:34:36 (8.25 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119968 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:36.750255) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:36.750566) ========= 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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.020041 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:36.798776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 14:34:36.799130) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ec97adea519ba55ac05a2af28534e0594b97f80e --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 ec97adea519ba55ac05a2af28534e0594b97f80e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GL7oBZ4Det/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.RymMtJi1Cw/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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-05-23 14:34:36,896 truncating revision to first 12 chars 2016-05-23 14:34:36,896 Setting DEBUG logging. 2016-05-23 14:34:36,896 attempt 1/10 2016-05-23 14:34:36,897 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ec97adea519b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 14:34:37,638 unpacking tar archive at: fx-team-ec97adea519b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.997777 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 14:34:37.843709) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:37.849109) ========= script_repo_revision: ec97adea519ba55ac05a2af28534e0594b97f80e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:37.849499) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:37.849780) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 14:34:37.974714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-05-23 14:34:37.974982) ========= /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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:34:38 INFO - MultiFileLogger online at 20160523 14:34:38 in /builds/slave/test 14:34:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:34:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:34:38 INFO - {'append_to_log': False, 14:34:38 INFO - 'base_work_dir': '/builds/slave/test', 14:34:38 INFO - 'blob_upload_branch': 'Fx-Team', 14:34:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:34:38 INFO - 'branch': 'Fx-Team', 14:34:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:34:38 INFO - 'config_files': ('talos/mac_config.py',), 14:34:38 INFO - 'default_actions': ('clobber', 14:34:38 INFO - 'read-buildbot-config', 14:34:38 INFO - 'download-and-extract', 14:34:38 INFO - 'populate-webroot', 14:34:38 INFO - 'create-virtualenv', 14:34:38 INFO - 'install', 14:34:38 INFO - 'run-tests'), 14:34:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:34:38 INFO - 'download_minidump_stackwalk': True, 14:34:38 INFO - 'download_symbols': 'ondemand', 14:34:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:34:38 INFO - 'tooltool.py': '/tools/tooltool.py', 14:34:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:34:38 INFO - '/tools/misc-python/virtualenv.py')}, 14:34:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:34:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:34:38 INFO - 'installer_path': 'installer.exe', 14:34:38 INFO - 'log_level': 'info', 14:34:38 INFO - 'log_name': 'talos', 14:34:38 INFO - 'log_to_console': True, 14:34:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:34:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:34:38 INFO - 'opt_config_files': (), 14:34:38 INFO - 'pip_index': False, 14:34:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:34:38 INFO - 'cmd': ('bash', 14:34:38 INFO - '-c', 14:34:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:34:38 INFO - 'enabled': True, 14:34:38 INFO - 'halt_on_failure': False, 14:34:38 INFO - 'name': 'check_screen_resolution'},), 14:34:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:34:38 INFO - 'cmd': ('bash', 14:34:38 INFO - '-c', 14:34:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:34:38 INFO - 'enabled': True, 14:34:38 INFO - 'halt_on_failure': False, 14:34:38 INFO - 'name': 'check_screen_resolution'},), 14:34:38 INFO - 'run_cmd_checks_enabled': True, 14:34:38 INFO - 'sps_profile': False, 14:34:38 INFO - 'sps_profile_interval': 0, 14:34:38 INFO - 'suite': 'dromaeojs-e10s', 14:34:38 INFO - 'system_bits': '32', 14:34:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:34:38 INFO - 'title': 't-yosemite-r7-0189', 14:34:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:34:38 INFO - 'use_talos_json': True, 14:34:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:34:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:34:38 INFO - 'work_dir': 'build'} 14:34:38 INFO - ##### 14:34:38 INFO - ##### Running clobber step. 14:34:38 INFO - ##### 14:34:38 INFO - Running pre-action listener: _resource_record_pre_action 14:34:38 INFO - Running main action method: clobber 14:34:38 INFO - rmtree: /builds/slave/test/build 14:34:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:34:39 INFO - Running post-action listener: _resource_record_post_action 14:34:39 INFO - ##### 14:34:39 INFO - ##### Finished clobber step (success) 14:34:39 INFO - ##### 14:34:39 INFO - ##### 14:34:39 INFO - ##### Running read-buildbot-config step. 14:34:39 INFO - ##### 14:34:39 INFO - Running pre-action listener: _resource_record_pre_action 14:34:39 INFO - Running main action method: read_buildbot_config 14:34:39 INFO - Using buildbot properties: 14:34:39 INFO - { 14:34:39 INFO - "project": "", 14:34:39 INFO - "product": "firefox", 14:34:39 INFO - "script_repo_revision": "production", 14:34:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:34:39 INFO - "repository": "", 14:34:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:34:39 INFO - "buildid": "20160523130801", 14:34:39 INFO - "pgo_build": "False", 14:34:39 INFO - "basedir": "/builds/slave/test", 14:34:39 INFO - "buildnumber": 12, 14:34:39 INFO - "slavename": "t-yosemite-r7-0189", 14:34:39 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:34:39 INFO - "platform": "yosemite_r7", 14:34:39 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 14:34:39 INFO - "branch": "fx-team", 14:34:39 INFO - "repo_path": "integration/fx-team", 14:34:39 INFO - "revision": "ec97adea519ba55ac05a2af28534e0594b97f80e", 14:34:39 INFO - "stage_platform": "macosx64", 14:34:39 INFO - "builduid": "7111702919aa4d0f925a7ba95f4d8d09", 14:34:39 INFO - "slavebuilddir": "test" 14:34:39 INFO - } 14:34:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 14:34:39 INFO - Running post-action listener: _resource_record_post_action 14:34:39 INFO - ##### 14:34:39 INFO - ##### Finished read-buildbot-config step (success) 14:34:39 INFO - ##### 14:34:39 INFO - ##### 14:34:39 INFO - ##### Running download-and-extract step. 14:34:39 INFO - ##### 14:34:39 INFO - Running pre-action listener: _resource_record_pre_action 14:34:39 INFO - Running main action method: download_and_extract 14:34:39 INFO - mkdir: /builds/slave/test/build/tests 14:34:39 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')]} 14:34:39 INFO - https://queue.taskcluster.net/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:34:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 14:34:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 14:34:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 14:34:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 14:34:40 INFO - Downloaded 1199 bytes. 14:34:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 14:34:40 INFO - Using the following test package requirements: 14:34:40 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 14:34:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:34:40 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 14:34:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:34:40 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 14:34:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:34:40 INFO - u'jsshell-mac.zip'], 14:34:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:34:40 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 14:34:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 14:34:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:34:40 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 14:34:40 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:34:40 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 14:34:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:34:40 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 14:34:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:34:40 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 14:34:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:34:40 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')]} 14:34:40 INFO - https://queue.taskcluster.net/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:34:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:34:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:34:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:34:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:34:41 INFO - Downloaded 18630429 bytes. 14:34:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:34:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:34:44 INFO - Return code: 0 14:34:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:34:44 INFO - https://queue.taskcluster.net/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:34:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:34:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:34:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:34:58 INFO - Downloaded 18630429 bytes. 14:34:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:34:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:35:02 INFO - Return code: 0 14:35:02 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')]} 14:35:02 INFO - https://queue.taskcluster.net/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:35:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 14:35:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 14:35:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 14:35:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:35:03 INFO - Downloaded 10840359 bytes. 14:35:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:35:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:35:04 INFO - Return code: 0 14:35:04 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')]} 14:35:04 INFO - https://queue.taskcluster.net/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:35:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:35:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:35:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 14:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 14:35:08 INFO - Downloaded 110153605 bytes. 14:35:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:35:08 INFO - mkdir: /builds/slave/test/properties 14:35:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:35:08 INFO - Writing to file /builds/slave/test/properties/build_url 14:35:08 INFO - Contents: 14:35:08 INFO - build_url:https://queue.taskcluster.net/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:35:09 INFO - Running post-action listener: _resource_record_post_action 14:35:09 INFO - Running post-action listener: set_extra_try_arguments 14:35:09 INFO - ##### 14:35:09 INFO - ##### Finished download-and-extract step (success) 14:35:09 INFO - ##### 14:35:09 INFO - ##### 14:35:09 INFO - ##### Running populate-webroot step. 14:35:09 INFO - ##### 14:35:09 INFO - Running pre-action listener: _resource_record_pre_action 14:35:09 INFO - Running main action method: populate_webroot 14:35:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:35:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:35:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:35:09 INFO - '--tppagecycles', 14:35:09 INFO - '7'], 14:35:09 INFO - 'tests': ['tsvgm']}}, 14:35:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:35:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:35:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:35:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:35:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:35:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:35:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:09 INFO - 'talos_options': ['--disable-e10s'], 14:35:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:09 INFO - 'talos_options': ['--disable-e10s'], 14:35:09 INFO - 'tests': ['damp', 'tps']}, 14:35:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:09 INFO - 'tests': ['damp', 'tps']}, 14:35:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:35:09 INFO - 'tests': ['dromaeo_dom']}, 14:35:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:35:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:35:09 INFO - 'tests': ['a11yr', 14:35:09 INFO - 'ts_paint', 14:35:09 INFO - 'tpaint', 14:35:09 INFO - 'sessionrestore', 14:35:09 INFO - 'sessionrestore_no_auto_restore', 14:35:09 INFO - 'tabpaint']}, 14:35:09 INFO - 'other-e10s': {'tests': ['a11yr', 14:35:09 INFO - 'ts_paint', 14:35:09 INFO - 'tpaint', 14:35:09 INFO - 'sessionrestore', 14:35:09 INFO - 'sessionrestore_no_auto_restore', 14:35:09 INFO - 'tabpaint']}, 14:35:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:35:09 INFO - 'ts_paint', 14:35:09 INFO - 'tpaint', 14:35:09 INFO - 'sessionrestore', 14:35:09 INFO - 'sessionrestore_no_auto_restore', 14:35:09 INFO - 'tabpaint']}, 14:35:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:35:09 INFO - 'ts_paint', 14:35:09 INFO - 'tpaint', 14:35:09 INFO - 'sessionrestore', 14:35:09 INFO - 'sessionrestore_no_auto_restore', 14:35:09 INFO - 'tabpaint']}, 14:35:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:35:09 INFO - 'tests': ['a11yr', 14:35:09 INFO - 'ts_paint', 14:35:09 INFO - 'tpaint', 14:35:09 INFO - 'sessionrestore', 14:35:09 INFO - 'sessionrestore_no_auto_restore', 14:35:09 INFO - 'tabpaint']}, 14:35:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:35:09 INFO - 'tests': ['a11yr', 14:35:09 INFO - 'ts_paint', 14:35:09 INFO - 'tpaint', 14:35:09 INFO - 'sessionrestore', 14:35:09 INFO - 'sessionrestore_no_auto_restore', 14:35:09 INFO - 'tabpaint']}, 14:35:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:35:09 INFO - 'tests': ['tsvgx', 14:35:09 INFO - 'tsvgr_opacity', 14:35:09 INFO - 'tart', 14:35:09 INFO - 'tscrollx', 14:35:09 INFO - 'cart']}, 14:35:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:35:09 INFO - 'tsvgr_opacity', 14:35:09 INFO - 'tart', 14:35:09 INFO - 'tscrollx', 14:35:09 INFO - 'cart']}, 14:35:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:09 INFO - 'talos_options': ['--disable-e10s'], 14:35:09 INFO - 'tests': ['tp5o']}, 14:35:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:09 INFO - 'tests': ['tp5o']}, 14:35:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:09 INFO - 'talos_options': ['--disable-e10s', 14:35:09 INFO - '--xperf_path', 14:35:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:09 INFO - 'tests': ['tp5n']}, 14:35:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:09 INFO - 'talos_options': ['--xperf_path', 14:35:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:09 INFO - 'tests': ['tp5n']}}, 14:35:09 INFO - 'talos.zip': {'path': '', 14:35:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:35:09 INFO - Running post-action listener: _resource_record_post_action 14:35:09 INFO - ##### 14:35:09 INFO - ##### Finished populate-webroot step (success) 14:35:09 INFO - ##### 14:35:09 INFO - ##### 14:35:09 INFO - ##### Running create-virtualenv step. 14:35:09 INFO - ##### 14:35:09 INFO - Running pre-action listener: _resource_record_pre_action 14:35:09 INFO - Running main action method: create_virtualenv 14:35:09 INFO - Creating virtualenv /builds/slave/test/build/venv 14:35:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:35:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:35:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:35:09 INFO - Using real prefix '/tools/python27' 14:35:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:35:09 INFO - Installing distribute.............................................................................................................................................................................................done. 14:35:12 INFO - Installing pip.................done. 14:35:12 INFO - Return code: 0 14:35:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:35:12 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')]} 14:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:12 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')]} 14:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:12 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 0x100886a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a477910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10072ad30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100721b20>, '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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:35:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GL7oBZ4Det/Render', 14:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:12 INFO - 'HOME': '/Users/cltbld', 14:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:12 INFO - 'LOGNAME': 'cltbld', 14:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:12 INFO - 'MOZ_NO_REMOTE': '1', 14:35:12 INFO - 'NO_EM_RESTART': '1', 14:35:12 INFO - 'PAGER': '/bin/cat', 14:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:12 INFO - 'PWD': '/builds/slave/test', 14:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:12 INFO - 'SHELL': '/bin/bash', 14:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RymMtJi1Cw/Listeners', 14:35:12 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 14:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:12 INFO - 'USER': 'cltbld', 14:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:12 INFO - 'XPC_FLAGS': '0x0', 14:35:12 INFO - 'XPC_SERVICE_NAME': '0', 14:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:35:13 INFO - Cleaning up... 14:35:13 INFO - Return code: 0 14:35:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:35: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')]} 14:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35: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')]} 14:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100886a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a477910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10072ad30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100721b20>, '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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:35:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:35:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GL7oBZ4Det/Render', 14:35:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:13 INFO - 'HOME': '/Users/cltbld', 14:35:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:13 INFO - 'LOGNAME': 'cltbld', 14:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:13 INFO - 'MOZ_NO_REMOTE': '1', 14:35:13 INFO - 'NO_EM_RESTART': '1', 14:35:13 INFO - 'PAGER': '/bin/cat', 14:35:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:13 INFO - 'PWD': '/builds/slave/test', 14:35:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:13 INFO - 'SHELL': '/bin/bash', 14:35:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RymMtJi1Cw/Listeners', 14:35:13 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 14:35:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:13 INFO - 'USER': 'cltbld', 14:35:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:13 INFO - 'XPC_FLAGS': '0x0', 14:35:13 INFO - 'XPC_SERVICE_NAME': '0', 14:35:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:13 INFO - Downloading/unpacking psutil>=3.1.1 14:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:35:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:16 INFO - Installing collected packages: psutil 14:35:16 INFO - Running setup.py install for psutil 14:35:16 INFO - building 'psutil._psutil_osx' extension 14:35:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:35:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:35:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:35:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:35:17 INFO - building 'psutil._psutil_posix' extension 14:35:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:35:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:35:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:35:17 INFO - ^ 14:35:17 INFO - 1 warning generated. 14:35:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:35:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:17 INFO - Successfully installed psutil 14:35:17 INFO - Cleaning up... 14:35:17 INFO - Return code: 0 14:35:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:35: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')]} 14:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35: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')]} 14:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100886a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a477910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10072ad30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100721b20>, '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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GL7oBZ4Det/Render', 14:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:17 INFO - 'HOME': '/Users/cltbld', 14:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:17 INFO - 'LOGNAME': 'cltbld', 14:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:17 INFO - 'MOZ_NO_REMOTE': '1', 14:35:17 INFO - 'NO_EM_RESTART': '1', 14:35:17 INFO - 'PAGER': '/bin/cat', 14:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:17 INFO - 'PWD': '/builds/slave/test', 14:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:17 INFO - 'SHELL': '/bin/bash', 14:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RymMtJi1Cw/Listeners', 14:35:17 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 14:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:17 INFO - 'USER': 'cltbld', 14:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:17 INFO - 'XPC_FLAGS': '0x0', 14:35:17 INFO - 'XPC_SERVICE_NAME': '0', 14:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:35:20 INFO - Installing collected packages: mozsystemmonitor 14:35:20 INFO - Running setup.py install for mozsystemmonitor 14:35:20 INFO - Successfully installed mozsystemmonitor 14:35:20 INFO - Cleaning up... 14:35:20 INFO - Return code: 0 14:35:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:35:20 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')]} 14:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:20 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')]} 14:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:20 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 0x100886a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a477910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10072ad30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100721b20>, '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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:35:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GL7oBZ4Det/Render', 14:35:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:20 INFO - 'HOME': '/Users/cltbld', 14:35:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:20 INFO - 'LOGNAME': 'cltbld', 14:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:20 INFO - 'MOZ_NO_REMOTE': '1', 14:35:20 INFO - 'NO_EM_RESTART': '1', 14:35:20 INFO - 'PAGER': '/bin/cat', 14:35:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:20 INFO - 'PWD': '/builds/slave/test', 14:35:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:20 INFO - 'SHELL': '/bin/bash', 14:35:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RymMtJi1Cw/Listeners', 14:35:20 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 14:35:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:20 INFO - 'USER': 'cltbld', 14:35:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:20 INFO - 'XPC_FLAGS': '0x0', 14:35:20 INFO - 'XPC_SERVICE_NAME': '0', 14:35:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:20 INFO - Downloading/unpacking blobuploader==1.2.4 14:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:23 INFO - Downloading blobuploader-1.2.4.tar.gz 14:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:35:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:35:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35:24 INFO - Downloading docopt-0.6.1.tar.gz 14:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:35:24 INFO - Installing collected packages: blobuploader, requests, docopt 14:35:24 INFO - Running setup.py install for blobuploader 14:35:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:35:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:35:24 INFO - Running setup.py install for requests 14:35:25 INFO - Running setup.py install for docopt 14:35:25 INFO - Successfully installed blobuploader requests docopt 14:35:25 INFO - Cleaning up... 14:35:25 INFO - Return code: 0 14:35:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:25 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')]} 14:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:25 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')]} 14:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:25 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 0x100886a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a477910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10072ad30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100721b20>, '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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GL7oBZ4Det/Render', 14:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:25 INFO - 'HOME': '/Users/cltbld', 14:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:25 INFO - 'LOGNAME': 'cltbld', 14:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:25 INFO - 'MOZ_NO_REMOTE': '1', 14:35:25 INFO - 'NO_EM_RESTART': '1', 14:35:25 INFO - 'PAGER': '/bin/cat', 14:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:25 INFO - 'PWD': '/builds/slave/test', 14:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:25 INFO - 'SHELL': '/bin/bash', 14:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RymMtJi1Cw/Listeners', 14:35:25 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 14:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:25 INFO - 'USER': 'cltbld', 14:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:25 INFO - 'XPC_FLAGS': '0x0', 14:35:25 INFO - 'XPC_SERVICE_NAME': '0', 14:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:25 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-LnCEKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:25 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-OLgONO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:25 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-aZY_ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:25 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-dh8ZXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:25 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-DtahOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:26 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-bUj6J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:26 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-lqcLXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:26 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-5TBD5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:26 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-umJ_9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:26 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-_8gxWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:26 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-YfOO68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:26 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-SzazR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:26 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-KTifXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:26 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-kOLp1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:27 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Zhf8ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:27 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-AMYSgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:27 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-ibpFzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:35:27 INFO - Running setup.py install for manifestparser 14:35:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Running setup.py install for mozcrash 14:35:27 INFO - Running setup.py install for mozdebug 14:35:27 INFO - Running setup.py install for mozdevice 14:35:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Running setup.py install for mozfile 14:35:28 INFO - Running setup.py install for mozhttpd 14:35:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Running setup.py install for mozinfo 14:35:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Running setup.py install for mozInstall 14:35:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Running setup.py install for mozleak 14:35:28 INFO - Running setup.py install for mozlog 14:35:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Running setup.py install for moznetwork 14:35:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Running setup.py install for mozprocess 14:35:29 INFO - Running setup.py install for mozprofile 14:35:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:35:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:35:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:35:29 INFO - Running setup.py install for mozrunner 14:35:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:35:29 INFO - Running setup.py install for mozscreenshot 14:35:29 INFO - Running setup.py install for moztest 14:35:29 INFO - Running setup.py install for mozversion 14:35:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:35:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:35:29 INFO - Cleaning up... 14:35:29 INFO - Return code: 0 14:35:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:29 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 0x100886a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a477910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10072ad30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100721b20>, '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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:35:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GL7oBZ4Det/Render', 14:35:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:29 INFO - 'HOME': '/Users/cltbld', 14:35:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:29 INFO - 'LOGNAME': 'cltbld', 14:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:29 INFO - 'MOZ_NO_REMOTE': '1', 14:35:29 INFO - 'NO_EM_RESTART': '1', 14:35:29 INFO - 'PAGER': '/bin/cat', 14:35:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:29 INFO - 'PWD': '/builds/slave/test', 14:35:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:29 INFO - 'SHELL': '/bin/bash', 14:35:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RymMtJi1Cw/Listeners', 14:35:29 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 14:35:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:29 INFO - 'USER': 'cltbld', 14:35:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:29 INFO - 'XPC_FLAGS': '0x0', 14:35:29 INFO - 'XPC_SERVICE_NAME': '0', 14:35:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:30 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-OPV2bO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:30 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-pOwHvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:30 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-IC5v1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:30 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-lDuk80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:30 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-DNGzO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:30 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-zYe6w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:30 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-xgEaDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:30 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-sDFs95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:31 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-tPulNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:31 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-nvh7ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:31 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-SJ8QgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:31 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-fgHAIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:31 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)) 14:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:31 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-sy7xAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:31 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-pmDVm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:31 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)) 14:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:31 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-uqdzwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:31 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-u3dMNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:31 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Cz3GYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:34 INFO - Downloading blessings-1.6.tar.gz 14:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:35:34 INFO - Installing collected packages: blessings 14:35:34 INFO - Running setup.py install for blessings 14:35:34 INFO - Successfully installed blessings 14:35:34 INFO - Cleaning up... 14:35:34 INFO - Return code: 0 14:35:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:35 INFO - Reading from file tmpfile_stdout 14:35:35 INFO - Current package versions: 14:35:35 INFO - blessings == 1.6 14:35:35 INFO - blobuploader == 1.2.4 14:35:35 INFO - docopt == 0.6.1 14:35:35 INFO - manifestparser == 1.1 14:35:35 INFO - mozInstall == 1.12 14:35:35 INFO - mozcrash == 0.17 14:35:35 INFO - mozdebug == 0.1 14:35:35 INFO - mozdevice == 0.48 14:35:35 INFO - mozfile == 1.2 14:35:35 INFO - mozhttpd == 0.7 14:35:35 INFO - mozinfo == 0.9 14:35:35 INFO - mozleak == 0.1 14:35:35 INFO - mozlog == 3.2 14:35:35 INFO - moznetwork == 0.27 14:35:35 INFO - mozprocess == 0.22 14:35:35 INFO - mozprofile == 0.28 14:35:35 INFO - mozrunner == 6.11 14:35:35 INFO - mozscreenshot == 0.1 14:35:35 INFO - mozsystemmonitor == 0.3 14:35:35 INFO - moztest == 0.7 14:35:35 INFO - mozversion == 1.4 14:35:35 INFO - psutil == 3.1.1 14:35:35 INFO - requests == 1.2.3 14:35:35 INFO - wsgiref == 0.1.2 14:35:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:35 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 0x100886a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a477910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10072ad30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100721b20>, '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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:35:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GL7oBZ4Det/Render', 14:35:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:35 INFO - 'HOME': '/Users/cltbld', 14:35:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:35 INFO - 'LOGNAME': 'cltbld', 14:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:35 INFO - 'MOZ_NO_REMOTE': '1', 14:35:35 INFO - 'NO_EM_RESTART': '1', 14:35:35 INFO - 'PAGER': '/bin/cat', 14:35:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:35 INFO - 'PWD': '/builds/slave/test', 14:35:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:35 INFO - 'SHELL': '/bin/bash', 14:35:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RymMtJi1Cw/Listeners', 14:35:35 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 14:35:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:35 INFO - 'USER': 'cltbld', 14:35:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:35 INFO - 'XPC_FLAGS': '0x0', 14:35:35 INFO - 'XPC_SERVICE_NAME': '0', 14:35:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:35:35 INFO - Cleaning up... 14:35:35 INFO - Return code: 0 14:35:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:35 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 0x100886a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a477910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10072ad30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100721b20>, '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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:35:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GL7oBZ4Det/Render', 14:35:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:35 INFO - 'HOME': '/Users/cltbld', 14:35:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:35 INFO - 'LOGNAME': 'cltbld', 14:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:35 INFO - 'MOZ_NO_REMOTE': '1', 14:35:35 INFO - 'NO_EM_RESTART': '1', 14:35:35 INFO - 'PAGER': '/bin/cat', 14:35:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:35 INFO - 'PWD': '/builds/slave/test', 14:35:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:35 INFO - 'SHELL': '/bin/bash', 14:35:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RymMtJi1Cw/Listeners', 14:35:35 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 14:35:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:35 INFO - 'USER': 'cltbld', 14:35:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:35 INFO - 'XPC_FLAGS': '0x0', 14:35:35 INFO - 'XPC_SERVICE_NAME': '0', 14:35:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:35 INFO - Downloading/unpacking jsonschema 14:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:35:37 INFO - Downloading/unpacking functools32 (from jsonschema) 14:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:38 INFO - Downloading functools32-3.2.3-2.tar.gz 14:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:35:38 INFO - warning: no files found matching '*.txt' 14:35:38 INFO - no previously-included directories found matching 'build' 14:35:38 INFO - no previously-included directories found matching 'dist' 14:35:38 INFO - no previously-included directories found matching '.git*' 14:35:38 INFO - Installing collected packages: jsonschema, functools32 14:35:38 INFO - Running setup.py install for functools32 14:35:38 INFO - warning: no files found matching '*.txt' 14:35:38 INFO - no previously-included directories found matching 'build' 14:35:38 INFO - no previously-included directories found matching 'dist' 14:35:38 INFO - no previously-included directories found matching '.git*' 14:35:38 INFO - Successfully installed jsonschema functools32 14:35:38 INFO - Cleaning up... 14:35:38 INFO - Return code: 0 14:35:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100886a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a477910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10072ad30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100721b20>, '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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GL7oBZ4Det/Render', 14:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:38 INFO - 'HOME': '/Users/cltbld', 14:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:38 INFO - 'LOGNAME': 'cltbld', 14:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:38 INFO - 'MOZ_NO_REMOTE': '1', 14:35:38 INFO - 'NO_EM_RESTART': '1', 14:35:38 INFO - 'PAGER': '/bin/cat', 14:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:38 INFO - 'PWD': '/builds/slave/test', 14:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:38 INFO - 'SHELL': '/bin/bash', 14:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RymMtJi1Cw/Listeners', 14:35:38 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 14:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:38 INFO - 'USER': 'cltbld', 14:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:38 INFO - 'XPC_FLAGS': '0x0', 14:35:38 INFO - 'XPC_SERVICE_NAME': '0', 14:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:39 INFO - Downloading/unpacking flake8 14:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:35:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:35:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:35:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:35:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:35:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:35:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:35:43 INFO - no previously-included directories found matching 'docs/_build' 14:35:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:35:43 INFO - Running setup.py install for pep8 14:35:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:35:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:35:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:35:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:35:43 INFO - no previously-included directories found matching 'docs/_build' 14:35:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:35:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:35:43 INFO - Cleaning up... 14:35:43 INFO - Return code: 0 14:35:43 INFO - Running post-action listener: _resource_record_post_action 14:35:43 INFO - Running post-action listener: _start_resource_monitoring 14:35:43 INFO - Starting resource monitoring. 14:35:43 INFO - ##### 14:35:43 INFO - ##### Finished create-virtualenv step (success) 14:35:43 INFO - ##### 14:35:43 INFO - ##### 14:35:43 INFO - ##### Running install step. 14:35:43 INFO - ##### 14:35:43 INFO - Running pre-action listener: _resource_record_pre_action 14:35:43 INFO - Running main action method: install 14:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:43 INFO - Reading from file tmpfile_stdout 14:35:43 INFO - Detecting whether we're running mozinstall >=1.0... 14:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:35:43 INFO - Reading from file tmpfile_stdout 14:35:43 INFO - Output received: 14:35:43 INFO - Usage: mozinstall [options] installer 14:35:43 INFO - Options: 14:35:43 INFO - -h, --help show this help message and exit 14:35:43 INFO - -d DEST, --destination=DEST 14:35:43 INFO - Directory to install application into. [default: 14:35:43 INFO - "/builds/slave/test"] 14:35:43 INFO - --app=APP Application being installed. [default: firefox] 14:35:43 INFO - mkdir: /builds/slave/test/build/application 14:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:36:17 INFO - Reading from file tmpfile_stdout 14:36:17 INFO - Output received: 14:36:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:36:17 INFO - Running post-action listener: _resource_record_post_action 14:36:17 INFO - ##### 14:36:17 INFO - ##### Finished install step (success) 14:36:17 INFO - ##### 14:36:17 INFO - ##### 14:36:17 INFO - ##### Running run-tests step. 14:36:17 INFO - ##### 14:36:17 INFO - Running pre-action listener: _resource_record_pre_action 14:36:17 INFO - Running main action method: run_tests 14:36:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:36:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:36:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:36:17 INFO - 2016-05-23 14:36:17.367 screenresolution[2350:19905] starting screenresolution argv=screenresolution get 14:36:17 INFO - 2016-05-23 14:36:17.370 screenresolution[2350:19905] Display 0: 1600x1200x32@60 14:36:17 INFO - 2016-05-23 14:36:17.376 screenresolution[2351:19910] starting screenresolution argv=screenresolution list 14:36:17 INFO - Available Modes on Display 0 14:36:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:36:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:36:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:36:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:36:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:36:17 INFO - Intel Iris: 14:36:17 INFO - Chipset Model: Intel Iris 14:36:17 INFO - Type: GPU 14:36:17 INFO - Bus: Built-In 14:36:17 INFO - VRAM (Dynamic, Max): 1536 MB 14:36:17 INFO - Vendor: Intel (0x8086) 14:36:17 INFO - Device ID: 0x0a2e 14:36:17 INFO - Revision ID: 0x0009 14:36:17 INFO - Displays: 14:36:17 INFO - Display: 14:36:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:36:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:36:17 INFO - Display Serial Number: 1600x1200 60 14:36:17 INFO - Main Display: Yes 14:36:17 INFO - Mirror: Off 14:36:17 INFO - Online: Yes 14:36:17 INFO - Rotation: Supported 14:36:17 INFO - Return code: 0 14:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:36:17 INFO - Python 2.7.3 14:36:17 INFO - Return code: 0 14:36:17 INFO - grabbing minidump binary from tooltool 14:36: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')]} 14:36:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10072ad30>, '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 0x10054edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100721b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:36:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:36:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:36:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:36:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:36:17 INFO - Return code: 0 14:36:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:36:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:36:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:36:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:36:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:36:18 INFO - Return code: 0 14:36:18 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/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:36:18 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/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0189 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GL7oBZ4Det/Render', 14:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:36:18 INFO - 'HOME': '/Users/cltbld', 14:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:36:18 INFO - 'LOGNAME': 'cltbld', 14:36:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:36:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:36:18 INFO - 'MOZ_NO_REMOTE': '1', 14:36:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:36:18 INFO - 'NO_EM_RESTART': '1', 14:36:18 INFO - 'PAGER': '/bin/cat', 14:36:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:36:18 INFO - 'PWD': '/builds/slave/test', 14:36:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:36:18 INFO - 'SHELL': '/bin/bash', 14:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RymMtJi1Cw/Listeners', 14:36:18 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 14:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:36:18 INFO - 'USER': 'cltbld', 14:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:36:18 INFO - 'XPC_FLAGS': '0x0', 14:36:18 INFO - 'XPC_SERVICE_NAME': '0', 14:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:36:18 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/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:36:19 INFO - mozversion application_buildid: 20160523130801 14:36:19 INFO - mozversion application_changeset: ec97adea519ba55ac05a2af28534e0594b97f80e 14:36:19 INFO - mozversion application_display_name: Nightly 14:36:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:36:19 INFO - mozversion application_name: Firefox 14:36:19 INFO - mozversion application_remotingname: firefox 14:36:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:36:19 INFO - mozversion application_vendor: Mozilla 14:36:19 INFO - mozversion application_version: 49.0a1 14:36:19 INFO - mozversion platform_buildid: 20160523130801 14:36:19 INFO - mozversion platform_changeset: ec97adea519ba55ac05a2af28534e0594b97f80e 14:36:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:36:19 INFO - mozversion platform_version: 49.0a1 14:36:19 INFO - using testdate: 1464039379 14:36:19 INFO - actual date: 1464039379 14:36:19 INFO - starting webserver on 'localhost:51515' 14:36:19 INFO - SUITE-START | Running 2 tests 14:36:19 INFO - TEST-START | dromaeo_css 14:36:19 INFO - operating with platform_type : mac_ 14:36:19 INFO - Initialising browser for dromaeo_css test... 14:36:19 INFO - TEST-INFO | started process 2369 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpkPJcyF/profile http://localhost:51515/getInfo.html) 14:36:22 INFO - PROCESS | 2369 | __metrics Screen width/height:1600/1200 14:36:22 INFO - PROCESS | 2369 | colorDepth:24 14:36:22 INFO - PROCESS | 2369 | Browser inner width/height: 1024/689 14:36:22 INFO - PROCESS | 2369 | __metrics 14:36:22 ERROR - PROCESS | 2369 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:36:22 INFO - TEST-INFO | 2369: exit 0 14:36:22 INFO - Browser initialized. 14:36:22 INFO - Running cycle 1/1 for dromaeo_css test... 14:36:22 INFO - TEST-INFO | started process 2372 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpkPJcyF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:34 INFO - PROCESS | 2372 | RSS: Main: 250142720 14:36:34 INFO - PROCESS | 2372 | 14:37:24 INFO - PROCESS | 2372 | 1464039444501 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:39:36 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51515/tests/dromaeo/cssquery-ext.html) 14:39:37 INFO - PROCESS | 2372 | RSS: Main: 261255168 14:39:37 INFO - PROCESS | 2372 | 14:42:39 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51515/tests/dromaeo/cssquery-ext.html (next: http://localhost:51515/tests/dromaeo/cssquery-jquery.html) 14:42:40 INFO - PROCESS | 2372 | RSS: Main: 273412096 14:42:40 INFO - PROCESS | 2372 | 14:45:42 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51515/tests/dromaeo/cssquery-mootools.html) 14:45:43 INFO - PROCESS | 2372 | RSS: Main: 275460096 14:45:43 INFO - PROCESS | 2372 | 14:48:44 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51515/tests/dromaeo/cssquery-prototype.html) 14:48:45 INFO - PROCESS | 2372 | RSS: Main: 276873216 14:48:45 INFO - PROCESS | 2372 | 14:51:48 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51515/tests/dromaeo/cssquery-yui.html) 14:51:49 INFO - PROCESS | 2372 | RSS: Main: 280313856 14:51:49 INFO - PROCESS | 2372 | 14:54:51 INFO - PROCESS | 2372 | Cycle 1(1): loaded http://localhost:51515/tests/dromaeo/cssquery-yui.html (next: http://localhost:51515/tests/dromaeo/cssquery-dojo.html) 14:54:51 INFO - PROCESS | 2372 | RSS: Main: 280936448 14:54:51 INFO - PROCESS | 2372 | 14:54:51 INFO - PROCESS | 2372 | __start_tp_report 14:54:51 INFO - PROCESS | 2372 | _x_x_mozilla_page_load 14:54:51 INFO - PROCESS | 2372 | _x_x_mozilla_page_load_details 14:54:51 INFO - PROCESS | 2372 | |i|pagename|runs| 14:54:51 INFO - PROCESS | 2372 | |0;dojo.html;3499.895003149906;3526.0832183632247;3540.415831387821;3545.2023294758683;3570.8571657133716;4743.715377077369;5763.942360576399;5839.795607153746;5849.7367618457165;5937.228160339156;5755.280589926259;5856.326522449919;5861.560382971273;5897.734601942912;5975.701214939258;5283.577313814895;5331.840044798643;5338.092524270884;5414.214938833867;5486.451354864522;5503.20203570482;5547.916781248285;5557.221988921554;5583.5254003409755;5593.412691667378;5256.264123022799;5337;5355.357357117171;5368.865778355573;5429.968306021863;5339.172428273585;5373.489518495737;5377.81177658784;5404.054290499147;5440.972795136038;5396.082665946798;5402.91895621566;5427.565794736412;5446.074167391553;5449.373322067973;5493.752781124859;5789.392113828072;5791.594588378815;5799.623024503394;5858.209141765849;6213.813585592439;6218.533609979269;6247.156633854417;6271.278802937675;6296.842578935518;6208.782692605782;6221.471174950089;6259.217597800275;6322.0200868865395;6327.5570710050315;4997.675151115239;5950.553708471882;6050.6974651267265;6068.3021452533085;6113.908291375633;6453.903191452132;6471.158749362553;6474.223093228748;6495.1231583736535;6521.630457603861;6125.662799505599;6171.074338849208;6215.9378406215355;6285.088662143963;6317.715702793385;6342.080398342215;6349.492040636738;6361.395667411589;6366.968165159237;6372.6495042773095;6129.754809807647;6213.937860621426;6262.530310226751;6281.96859015702;6283.842903927439;6156.415140561639;6191.535634827406;6193.659348735863;6235.906461403082;6278.15244941927;5052.343195384577;5072.492750724972;5085.211792172219;5096.541311282002;5138.820141295111;4488.640908727294;4572.565606267399;4578.5650363215445;4580.862574122782;4628.83799067031;5723.77104915807;5880.558958078162;5880.970595147082;5990.311114221833;6038.758449662052;5320.787168513216;6156.384361563897;6157.599756015845;6240.875182496325;6278.30938596754;5822.301323841166;5851.531877449794;5933.525317974551;5940.138679891478;5963.224780778471;5434.782608695687;5486.61593688438;5504.889902201933;5509.47659972302;5521.806736764194;6453.774117905851;6490.870182596322;6526;6591.406773390418;6597.175353080865;6284.717187726655;6293.937060629335;6325.683715814283;6346.524010699124;6347.777827776005;6329.778457753957;6449.871002579828;6612.5040621952585;6625.966870165618;6629.502787290876;6192.040233763774;6270.843228919313;6273.435390814849;6282.2147231596055;6288.402601752826;6235.376462353728;6266.122742815918;6282.371762823681;6304.464120549805;6366.713497892699;6106.946079819441;6156.476699480415;6181.752729890754;6270.372962703693;6281.842953926189;6197.349278325892;6210.875782484235;6272.937270627235;6274.59215151032;6281.026440901667;5589.167386920215;5678;6056.454919057306;6164.753409863734;6203.96898015507;6098.91636565712;6155.815325540241;6172.105044768573;6234.189555357774;6281.937180628135;6174.104754810617;6183.690815459119;6183.721732522137;6188.690565471618;6212.161358216764 14:54:51 INFO - PROCESS | 2372 | |1;ext.html;481.4559547711086;504.4803852032408;514.927910092587;538.4830562659846;554.9528290095343;31307.843460782693;37910.81044594773;38974.415383769265;41055;41087.17825643489;38589;39477;42912.57087429125;42949.78525107378;43030.92422689434;9535.284853635987;9667.178289845371;9670.226381889432;9748.610055597768;9752;9607.039296070407;9719.319647624669;9739.561719722595;9753.853692194623;9783.412995220275;8596.656133754643;8717.779510868484;9739.805203895918;9760.511974401286;9772.267079968995;9664.951675241615;9737.51312434379;9742.561584728704;9751.707448776513;9764.365316254421;9518;9616.038396160398;9622;9653.662121825702;9664.226861851035;38631.80684096562;38655.613443865484;38698.41952370717;38769.612303876886;38832.41751373732;3156.5580818685403;3176.301213732975;3234.4824828027636;3419.4186988212064;3597.334493118781;27819.304517387023;27935;28182;28403.71596284052;28711.13866584006;2676.357674158188;2733.3439974406;2745.5607102863446;2856.371598248382;2858.3425812063133;502100;507929;508459;508793;509680.4515977433;33966.81116160923;62027.37972620216;62437;62464.37535624586;62488.06267905985;35210.8239458801;35758;36060.29547783927;36208;36215.63784362176;14493.492727754478;14895;14927.776083358758;14935.327910244065;15032.699346013018;12269.815952760715;12327.445264963098;12643.810342844865;12701.93649031749;12723.109382343147;6718.731250750013;7519.022527071445;7914.564698941614;7983.281504664492;7991.800204994922;3266.5590145330552;3312.966870331266;3316.966830331714;3323.80057196569;3340.1315657929113;922.5525620074259;931.5621657820814;996.8554559588819;1059.998301604976;1089.7765957978595;28174.43651126966;29423.823047077876;29684.703152968625;29815;30001.549976750368;816.8774683797359;940.5626383731598;1147.5696613769837;1167.258790667932;1191.2018947305326;15079.698406031817;15199.468018619295;15275.930684852176;15506.84493155054;15544.844551554566;670698;674700;679987;681367;682240;58509.4149058504;59813.40186598165;60232;60357.698211508665;60768;1389.485890220625;1401.5795261421736;1448.0659974316718;1450.5938337265582;1456.0753921259864;25713.614295785952;26399.736002640497;28900.566491503065;29302.26744331409;29351.70648293575;50936;51216.23175652443;51616.48383516267;51635.2254716172;51670.74164629153;596599.1020269399;599578;600166;600810;600825;25995.870020649774;26368.340791480365;26436;26653.86673066622;26774.330641734112;46119.077618448115;46532.534674654176;46768.36310729108;47474.050518990116;47517.76241118772;37724.81137594295;37995.43006854844;38293;38336;38741.6125838738;36253;37507;38176.618233818415;38321.23357532889;38329.33413317292;31790.04629861108;36300.729474468266;37132.44301335536;37629.247415052094;37758;29424.705752942198;31563.89526366566;33078.842240521466;33562;33924.812631557776;23490.325191473163;23864.880675596512;24889.87555062213;24970.37574060663;25315.87342063278 14:54:51 INFO - PROCESS | 2372 | |2;jquery.html;322.5194460254222;375.83087610575245;382.20882772660593;382.4912865888368;404.92711311963836;19719.11263993122;19889.701654475193;20767.169313227452;21002.15991360344;21015.36953891382;10068.395896246231;11704.941475292633;11748;12295.877041229585;12296.077794165429;4854.805807767685;5249.606279529041;5414.620976531644;5446.1558458439;5448.42791506892;3869.9806500967456;5771.971140144294;6090.299615544202;6103.87792244157;6183.87632247357;5924.140999555062;6055.788047418341;6136.23297087864;6147.60040597362;6170.074488826667;5964.1650168976375;6014.729337179816;6026.758929642809;6081.422264884829;6092.969535152318;5140.331756871583;5535.169724541311;5547.057000309957;5804.970975145139;5806;22357;24999.12503062402;25243.368915777068;25547.105851295302;25705.97176112953;2138.2409244718056;2185.115028413479;2283.760205178449;2331.49872777352;2654.3554562859035;9557.235421166359;9766.267529935212;10173.694789156338;10196.286259961806;13288.468461261538;1613.3869129730745;1616.9110698911554;1689.3073839725776;1720.2946791815295;1828.6799810033324;97119;105270.42094368591;119536;119927.4003629985;122225;11488.827667584992;11689.76620467586;11820.468078936468;11845.170838041255;11922.401054355234;14642.341094650767;14672.559823205322;14681.632959176106;14701.779473307908;14762.557123286319;8625.956870215734;8682.044975052739;8734.694285700098;8753;8780.078091800397;7141.678624461912;8460.746177614681;8599.183077607617;8696.565171741388;8709.129087091367;4057.736247143926;4425.712328698624;4426.782634775463;4556;4574.062317224961;1590.3877007352253;1837.5865430278348;1921.8942958137156;1963.0675429171315;1970.5566247594177;858.9214101873481;872.6204101215991;937.1846493550654;938.6902322233647;985.1626117799956;19389.709154362696;20114.69827952582;20180.39458816238;20222.898885505772;20365.79634203639;913.8903331600118;937.6249500199974;946.4084946908182;968.4915419404728;973.3721749471551;8535.658573656985;10507.527161277761;10718.624848130434;10731.83902241467;10794.974477424632;603161;608008;613236.933815328;613536;619366;132001;135516;137404;140508;142488.5751142496;1000.7698229407277;1009.9596016159418;1028.2596530498029;1033.565902321012;1038.2835843268272;13738.519151829638;14359.210243436712;17692.82307176963;17842.821571784116;17892;49319.013619726684;50126.74936625294;52129.739351303004;53148;53375.733121334146;60585;72264;75775.62112189404;76176;77548.2245177541;8019.518828870287;8051.275385215359;8088.150744171778;8171.795705107182;8192.795180120307;10614.310069845435;11505.194636375709;12328.691782705504;12549.184303020274;12632.74734505323;9189.127032931861;10144.391336519833;10644.095251903675;10820.837687434852;10942.890571094187;9294;10542.683719488428;10652.520636571528;10810.783784324112;10939;10184.745381365525;10572.259941803999;10931.508082136483;11385.975262226439;11529.308241505536;8123.5532045738055;8145.918540814753;8185.549794761345;8307.626156822836;8531.061583225715;8945.776355591162;10401;10626.89373106259;11050.281731687415;11134.777304454028 14:54:51 INFO - PROCESS | 2372 | |3;mootools.html;1512.2136489025706;1535.009918602501;1817.1368599915043;1944.4847115514392;1986.503374156461;8127.390445716565;8716.389852710305;8784.51685157316;9233.815323693521;9236.399634023785;7588.962055189731;8820.691275805348;8864.734057978254;9025.819483610323;9048.819023619524;2370.9051637934504;2417.830751847371;2418.673479080328;2418.891149898259;2421.515696860626;2357.1867705641525;2412.445137618349;2416.4683769570665;2434.2697190842678;2440.6095024796036;1981.821636052755;2423.75762423758;2426.357015390914;2431.720352159498;2432.902683892642;1970.7733610634816;2009.447401964457;2387.510560335127;2390.8924098415528;2413.4207790130417;2363.929082127539;2368.01727283179;2387.877697482181;2389.474315650554;2391.4021494626345;8934.017258101603;8943.731688049369;9021.188093071654;9027.774305642346;9055.81888362229;5323.201519772027;5418.539424148952;5491.7254137292975;5503.972480137613;5509.9255645149215;3054.9541756873664;3184.5541624172633;3319.468884978392;3546.2198316370614;3547.7161827053774;1020.9081182693519;1030.5259580592935;1031.0771859185986;1037.444966942682;1039.6101461951769;11834.822477662756;11888.762224755457;11961.940190298992;11997.280163190237;12030.69923251917;4809.158397280532;4832.323474713543;4856.635752318591;4868.099401610713;4905.9264111038365;9996.050375214343;10096.141827944706;10189.490525473697;10206.489675516195;10234.795304093876;5389.784408623689;5405;5406.972965135228;5445.53712934405;5447.754851031713;4484.753338566345;4862.586680132157;4946.8763280918265;5033;5035.16919708244;4023.8994025149605;4051.7771522565954;4121.155163191538;4134.565870583606;4178.561251068594;1293.7606542789426;1301.9544315948897;1315.1780137414116;1316.7169058652435;1317.7101037771674;691.5781373362245;897.4032268541347;925.1904583489446;937.3719607862748;945.6595625574788;5312.389075256395;5804.767809287666;5956.6723830188885;6089.238845144357;6120.051392034242;918.0589895357178;934.3926447808979;941.9011003844635;951.7382719751985;952.2905435450633;3833.9041523961564;3932.783696896698;3951.604839516083;3992.7604343739467;4013.097053163015;10422.947885260677;10667.626633067805;10811.83782243267;10816.67549973502;10891.292066015683;9197.540122993823;10571.524281407355;10881.673549793519;10937.179711521667;10943.83584246237;8181.3863960203225;8406.705765298308;8410.369222308229;8420.452670576393;8455.957720211483;5776.595638305446;5860.677662728591;6062.120992456157;6066.484348830399;6183.81448556544;9837.803243935225;9896.406215627085;10172.745681358025;10199.337043092175;10200.744981375525;10011.699649010541;10148.746281343025;10175.084242418217;10369;10383.53274102652;6784.898226526508;6993.930060699327;7505.099388073466;7640.159582445815;7666.386689064973;8373.33013358942;8436.409451338348;8466.619002145042;8473.195046470575;8519.318454523747;7380.261973802577;7485.1766305707415;7526.5860377679755;7618.6190690466365;7627.5042122261875;7357.668904899399;7401.592912389655;7431.8142046449275;7500.287472690085;7510.849783004419;6932.237453879969;6988.720451182099;6994.965025175045;6998.720051198099;6999.860002799814;4761.262004389325;4808.639352048541;4904.2643603459765;4953.702777833341;5063.898722025465;3759.7368184226843;4151.3772934058925;4928.457869634266;5041.924371134362;5172.793088276427 14:54:51 INFO - PROCESS | 2372 | |4;prototype.html;306.9140640620626;307.63852473343815;310.63810660580424;313.1935266688278;315.4574132492113;5530.5022547970675;5569.498745112939;5610.232776675344;5664.801731939383;5675.6878371689545;5489.478499542547;5489.972550137254;5544.473275038875;5549.417311182328;5567.693776842272;3505.4216054351;3982.1836523512684;4074.8166332515107;4187.28816101262;4196.895077623069;4133.979330103345;4169;4178.644815190697;4201.6008479194425;4206.263903816835;3288.6546912574195;3401.812900290483;4148.771817550049;4150.937735933963;4184.727992680466;3480.9477857832153;3530.735194860396;4052.6555242804397;4091.7340372875965;4127.36025915982;3404.8889688393106;3496.6712649193396;3545.4150065239205;3559.5728512578658;3570.4111670306725;4714.96270820419;5098.4646612105935;5320.244319374636;5321.973390133025;5356.625036247464;4358.629516491102;4574.9521370496595;4644.489106198315;4707.552782485658;4750.358701575277;5067.619928505377;5412.269343638637;5765.500969747854;5799.506212328697;5801.564882633819;3078.630564332272;3903.960960390388;3907.316219661548;3927.6465118139504;3987.983064318609;5341.599380046512;5830.883382332329;5858.3848695886745;5943.3462319144855;6019.036954087369;3205.9198520037185;3936.9212615747524;3965.960340396559;3973.7019723520852;3977.5226972763453;3547.450145227494;4006.699497537638;4012.29784787661;4021.859234926822;4023.1551374211745;4194.119234960693;4424.911501769947;4659.95340046602;4687.929681054787;4692.554207350297;5098.770555325019;5404.513593776579;5817.3019237690905;5847;5853;1137.7895089408487;1170.7716995185856;1347.995743171324;1357.891368690522;1374.731927274192;824.5052968219021;838.6687258532967;844.5059640110604;855.5978690015808;896.2068569316202;4601.585857272861;4956.529129732669;5007.574356179693;5363.517283444431;5367.530935769511;5184.870378240575;5918.733656985446;5941.940580594139;5959.404059594006;5965.403459654;4548.2722764358205;4763.476017638057;5043.646944713908;5366.838994830161;5380.650257733235;2890.783191260664;3013.819170849756;3124.4063627911078;3143.858526366319;3153.274746808201;6111.35830737775;6131.099359198663;6165.8458538536;6165.961295351552;6220.782272620437;5183.740812959337;5290.259363689087;6192.907106393408;6222.751089956351;6229.034499652561;5015.448300686921;5385.272988146628;6255.437010669061;6305.896468118061;6344.492440604833;5182.579497531611;5947.3457919627945;5949.791757288474;5982.162497250475;6023.216981792339;5464.3442786865835;5950.613210141327;5965.552583556338;5967.8209653710455;5995;5090.796368145233;5768.394318596487;6026.849328766816;6242.406971337716;6316.494680425463;3687.797171155612;3781.6029316922427;3905.863294784669;3958.5645578986864;3970.4441378207653;5068.619853510928;5131.640785145004;5519.668819870821;6014.879702406015;6014.939915556894;4134.937975930424;5874.236349274567;5907.32065812437;5922.822315330547;5934.575701831443;4823.95176048235;4899.289603007615;5328.706921119376;5664.603477756682;5827.70861456917;5033.874153146201;5360;5488.25908502363;5700.572457065819;5713.828825002163;5106.387233532;5632.352794186726;5783.8554036149435;5795.971020144872;5803.274590676166;4598.91872445469;4624.375709279204;4827.08285425768;4832.661713680009;5344.438833922382 14:54:51 INFO - PROCESS | 2372 | |5;yui.html;686.3273991488342;695.3429009585943;700.737223541172;717.5264325545139;718.357070421972;14999.625009374771;15269.61825954349;15391;15456.072635641869;15613.907026508148;14319.856801431983;14388.784168237486;14405.855941440583;14409.78385324221;14420.783688244685;872.4590753732679;893.4817805672727;920.2591913509622;923.7736754495124;934.3226161033265;910.3263584947125;930.1675000874247;933.6965486216973;938.4932136646203;942.2979879989417;970.6457143142773;972.7859870828406;975.2588033094863;975.4098770243971;976.2970661124015;956.2350119904049;960.6637676813094;962.4417837654144;966.4781018250136;969.6606187834237;709.7586820481062;715.0632671200692;722.7036914864933;723.4646361692362;724.0298000679063;15262.771058434133;15330.540083797503;15376.461823836113;15384.384624615002;15394.769078463833;12203.3392963625;12267.509299628004;12453.439595218237;12470.875291247154;13100.934495327558;8698.695545655872;9660.613575456973;9814.509274536245;9872.062154095349;10389.740256493573;3934.7048971327263;4022.0198857119935;4060.979695101535;4063.227986682521;4209.389638502431;74683;75537.86693199606;75698.62150689212;79386.20613793845;81123.5943820283;9223.44659320443;9300.767480812898;9337.673181438617;9534.95232523833;9618.134367906921;20152.59694806125;20257.08843102064;20330.593388132154;20367;20594.794052059588;7055.576665400093;7115.786526404217;7149.428045756327;7171.067761191011;7481;3899.395593682984;3907.9218415631526;3928.096537796323;3929.941050884239;3940.1134744682217;2947.3957838643028;3326.434506133963;3327.584051993501;3334.733221342287;3348.363810875926;610.6610830988755;612.2561088277675;626.837022374186;627.3914303125961;638.6104476269472;513.5634710496048;517.6428264497484;525.6805418399844;552.499987511303;566.8922904648103;7708.961455192688;7814.882776758353;7849.529028258208;7915.525068495794;8053.033635963605;491.0945875843016;510.50812442890805;544.0777881490914;574.6982834012177;594.9524038076944;3754.9436758448646;3790.3935370340614;3818.9236215275537;3822.8853134406013;3833.5974722654278;65972.34027659662;91303.54348228217;92110.15779684369;93039.53480232555;93087.53456232675;76643;77591.61204193943;80451.59774201091;80656.38687226223;81063.59468202622;65249;68026;68034.99999999901;68113;69154;8035.035795704553;8320.916790832014;8450.788730281793;8483.44857584255;8493.405461617875;31879.681203187673;39579;41675.7916210417;41925;43226;42693.78653106715;58844.41155588561;60461.09308360466;60983.085253722114;63003.6849815748;10793.29843560166;10844.457777110954;11106;11329.660110196708;11516.078713703051;11835.763284734428;11843.822342664695;11876.287422754662;11888.643340699793;11955.820662690241;11348.602798901999;11451.885481145415;11546.711332216762;11670.591529296773;11696.415179240834;11353.48909299067;11442.942785286354;11614.128940329678;11670.358130302575;11869.40652967331;11278.210525263154;11296;11574.47914843851;11596.072314215011;11597.304161750322;9509.952450237704;9649.035096490295;9661.526777059527;9923.851142232728;10117.342372745748;8414.83170336602;9366.531673416166;9596.625362509987;10087.949560252151;10188.184945204217 14:54:51 INFO - PROCESS | 2372 | __end_tp_report 14:54:51 INFO - PROCESS | 2372 | __start_cc_report 14:54:51 INFO - PROCESS | 2372 | _x_x_mozilla_cycle_collect,434 14:54:51 INFO - PROCESS | 2372 | __end_cc_report 14:54:51 INFO - PROCESS | 2372 | __startTimestamp1464040491922__endTimestamp 14:54:51 INFO - PROCESS | 2372 | 14:54:51 INFO - PROCESS | 2372 | ------- Summary: start ------- 14:54:51 INFO - PROCESS | 2372 | Number of tests: 6 14:54:51 INFO - PROCESS | 2372 | 14:54:51 INFO - PROCESS | 2372 | [#0] dojo.html Cycles:165 Average:5861.04 Median:6129.75 stddev:626.20 (10.2%) stddev-sans-first:600.10 14:54:51 INFO - PROCESS | 2372 | Values: 3499.9 3526.1 3540.4 3545.2 3570.9 4743.7 5763.9 5839.8 5849.7 5937.2 5755.3 5856.3 5861.6 5897.7 5975.7 5283.6 5331.8 5338.1 5414.2 5486.5 5503.2 5547.9 5557.2 5583.5 5593.4 5256.3 5337.0 5355.4 5368.9 5430.0 5339.2 5373.5 5377.8 5404.1 5441.0 5396.1 5402.9 5427.6 5446.1 5449.4 5493.8 5789.4 5791.6 5799.6 5858.2 6213.8 6218.5 6247.2 6271.3 6296.8 6208.8 6221.5 6259.2 6322.0 6327.6 4997.7 5950.6 6050.7 6068.3 6113.9 6453.9 6471.2 6474.2 6495.1 6521.6 6125.7 6171.1 6215.9 6285.1 6317.7 6342.1 6349.5 6361.4 6367.0 6372.6 6129.8 6213.9 6262.5 6282.0 6283.8 6156.4 6191.5 6193.7 6235.9 6278.2 5052.3 5072.5 5085.2 5096.5 5138.8 4488.6 4572.6 4578.6 4580.9 4628.8 5723.8 5880.6 5881.0 5990.3 6038.8 5320.8 6156.4 6157.6 6240.9 6278.3 5822.3 5851.5 5933.5 5940.1 5963.2 5434.8 5486.6 5504.9 5509.5 5521.8 6453.8 6490.9 6526.0 6591.4 6597.2 6284.7 6293.9 6325.7 6346.5 6347.8 6329.8 6449.9 6612.5 6626.0 6629.5 6192.0 6270.8 6273.4 6282.2 6288.4 6235.4 6266.1 6282.4 6304.5 6366.7 6106.9 6156.5 6181.8 6270.4 6281.8 6197.3 6210.9 6272.9 6274.6 6281.0 5589.2 5678.0 6056.5 6164.8 6204.0 6098.9 6155.8 6172.1 6234.2 6281.9 6174.1 6183.7 6183.7 6188.7 6212.2 14:54:51 INFO - PROCESS | 2372 | 14:54:51 INFO - PROCESS | 2372 | [#1] ext.html Cycles:180 Average:70734.67 Median:38332.67 stddev:160670.30 (419.1%) stddev-sans-first:161034.44 14:54:51 INFO - PROCESS | 2372 | Values: 481.5 504.5 514.9 538.5 555.0 31307.8 37910.8 38974.4 41055.0 41087.2 38589.0 39477.0 42912.6 42949.8 43030.9 9535.3 9667.2 9670.2 9748.6 9752.0 9607.0 9719.3 9739.6 9753.9 9783.4 8596.7 8717.8 9739.8 9760.5 9772.3 9665.0 9737.5 9742.6 9751.7 9764.4 9518.0 9616.0 9622.0 9653.7 9664.2 38631.8 38655.6 38698.4 38769.6 38832.4 3156.6 3176.3 3234.5 3419.4 3597.3 27819.3 27935.0 28182.0 28403.7 28711.1 2676.4 2733.3 2745.6 2856.4 2858.3 502100.0 507929.0 508459.0 508793.0 509680.5 33966.8 62027.4 62437.0 62464.4 62488.1 35210.8 35758.0 36060.3 36208.0 36215.6 14493.5 14895.0 14927.8 14935.3 15032.7 12269.8 12327.4 12643.8 12701.9 12723.1 6718.7 7519.0 7914.6 7983.3 7991.8 3266.6 3313.0 3317.0 3323.8 3340.1 922.6 931.6 996.9 1060.0 1089.8 28174.4 29423.8 29684.7 29815.0 30001.5 816.9 940.6 1147.6 1167.3 1191.2 15079.7 15199.5 15275.9 15506.8 15544.8 670698.0 674700.0 679987.0 681367.0 682240.0 58509.4 59813.4 60232.0 60357.7 60768.0 1389.5 1401.6 1448.1 1450.6 1456.1 25713.6 26399.7 28900.6 29302.3 29351.7 50936.0 51216.2 51616.5 51635.2 51670.7 596599.1 599578.0 600166.0 600810.0 600825.0 25995.9 26368.3 26436.0 26653.9 26774.3 46119.1 46532.5 46768.4 47474.1 47517.8 37724.8 37995.4 38293.0 38336.0 38741.6 36253.0 37507.0 38176.6 38321.2 38329.3 31790.0 36300.7 37132.4 37629.2 37758.0 29424.7 31563.9 33078.8 33562.0 33924.8 23490.3 23864.9 24889.9 24970.4 25315.9 14:54:51 INFO - PROCESS | 2372 | 14:54:51 INFO - PROCESS | 2372 | [#2] jquery.html Cycles:180 Average:34890.88 Median:25626.54 stddev:102114.31 (398.5%) stddev-sans-first:102367.78 14:54:51 INFO - PROCESS | 2372 | Values: 322.5 375.8 382.2 382.5 404.9 19719.1 19889.7 20767.2 21002.2 21015.4 10068.4 11704.9 11748.0 12295.9 12296.1 4854.8 5249.6 5414.6 5446.2 5448.4 3870.0 5772.0 6090.3 6103.9 6183.9 5924.1 6055.8 6136.2 6147.6 6170.1 5964.2 6014.7 6026.8 6081.4 6093.0 5140.3 5535.2 5547.1 5805.0 5806.0 22357.0 24999.1 25243.4 25547.1 25706.0 2138.2 2185.1 2283.8 2331.5 2654.4 9557.2 9766.3 10173.7 10196.3 13288.5 1613.4 1616.9 1689.3 1720.3 1828.7 97119.0 105270.4 119536.0 119927.4 122225.0 11488.8 11689.8 11820.5 11845.2 11922.4 14642.3 14672.6 14681.6 14701.8 14762.6 8626.0 8682.0 8734.7 8753.0 8780.1 7141.7 8460.7 8599.2 8696.6 8709.1 4057.7 4425.7 4426.8 4556.0 4574.1 1590.4 1837.6 1921.9 1963.1 1970.6 858.9 872.6 937.2 938.7 985.2 19389.7 20114.7 20180.4 20222.9 20365.8 913.9 937.6 946.4 968.5 973.4 8535.7 10507.5 10718.6 10731.8 10795.0 603161.0 608008.0 613236.9 613536.0 619366.0 132001.0 135516.0 137404.0 140508.0 142488.6 1000.8 1010.0 1028.3 1033.6 1038.3 13738.5 14359.2 17692.8 17842.8 17892.0 49319.0 50126.7 52129.7 53148.0 53375.7 60585.0 72264.0 75775.6 76176.0 77548.2 8019.5 8051.3 8088.2 8171.8 8192.8 10614.3 11505.2 12328.7 12549.2 12632.7 9189.1 10144.4 10644.1 10820.8 10942.9 9294.0 10542.7 10652.5 10810.8 10939.0 10184.7 10572.3 10931.5 11386.0 11529.3 8123.6 8145.9 8185.5 8307.6 8531.1 8945.8 10401.0 10626.9 11050.3 11134.8 14:54:51 INFO - PROCESS | 2372 | 14:54:51 INFO - PROCESS | 2372 | [#3] mootools.html Cycles:180 Average:5755.61 Median:4886.18 stddev:3241.45 (66.3%) stddev-sans-first:3234.86 14:54:51 INFO - PROCESS | 2372 | Values: 1512.2 1535.0 1817.1 1944.5 1986.5 8127.4 8716.4 8784.5 9233.8 9236.4 7589.0 8820.7 8864.7 9025.8 9048.8 2370.9 2417.8 2418.7 2418.9 2421.5 2357.2 2412.4 2416.5 2434.3 2440.6 1981.8 2423.8 2426.4 2431.7 2432.9 1970.8 2009.4 2387.5 2390.9 2413.4 2363.9 2368.0 2387.9 2389.5 2391.4 8934.0 8943.7 9021.2 9027.8 9055.8 5323.2 5418.5 5491.7 5504.0 5509.9 3055.0 3184.6 3319.5 3546.2 3547.7 1020.9 1030.5 1031.1 1037.4 1039.6 11834.8 11888.8 11961.9 11997.3 12030.7 4809.2 4832.3 4856.6 4868.1 4905.9 9996.1 10096.1 10189.5 10206.5 10234.8 5389.8 5405.0 5407.0 5445.5 5447.8 4484.8 4862.6 4946.9 5033.0 5035.2 4023.9 4051.8 4121.2 4134.6 4178.6 1293.8 1302.0 1315.2 1316.7 1317.7 691.6 897.4 925.2 937.4 945.7 5312.4 5804.8 5956.7 6089.2 6120.1 918.1 934.4 941.9 951.7 952.3 3833.9 3932.8 3951.6 3992.8 4013.1 10422.9 10667.6 10811.8 10816.7 10891.3 9197.5 10571.5 10881.7 10937.2 10943.8 8181.4 8406.7 8410.4 8420.5 8456.0 5776.6 5860.7 6062.1 6066.5 6183.8 9837.8 9896.4 10172.7 10199.3 10200.7 10011.7 10148.7 10175.1 10369.0 10383.5 6784.9 6993.9 7505.1 7640.2 7666.4 8373.3 8436.4 8466.6 8473.2 8519.3 7380.3 7485.2 7526.6 7618.6 7627.5 7357.7 7401.6 7431.8 7500.3 7510.8 6932.2 6988.7 6995.0 6998.7 6999.9 4761.3 4808.6 4904.3 4953.7 5063.9 3759.7 4151.4 4928.5 5041.9 5172.8 14:54:51 INFO - PROCESS | 2372 | 14:54:51 INFO - PROCESS | 2372 | [#4] prototype.html Cycles:180 Average:4618.99 Median:5102.58 stddev:1457.01 (28.6%) stddev-sans-first:1424.69 14:54:51 INFO - PROCESS | 2372 | Values: 306.9 307.6 310.6 313.2 315.5 5530.5 5569.5 5610.2 5664.8 5675.7 5489.5 5490.0 5544.5 5549.4 5567.7 3505.4 3982.2 4074.8 4187.3 4196.9 4134.0 4169.0 4178.6 4201.6 4206.3 3288.7 3401.8 4148.8 4150.9 4184.7 3480.9 3530.7 4052.7 4091.7 4127.4 3404.9 3496.7 3545.4 3559.6 3570.4 4715.0 5098.5 5320.2 5322.0 5356.6 4358.6 4575.0 4644.5 4707.6 4750.4 5067.6 5412.3 5765.5 5799.5 5801.6 3078.6 3904.0 3907.3 3927.6 3988.0 5341.6 5830.9 5858.4 5943.3 6019.0 3205.9 3936.9 3966.0 3973.7 3977.5 3547.5 4006.7 4012.3 4021.9 4023.2 4194.1 4424.9 4660.0 4687.9 4692.6 5098.8 5404.5 5817.3 5847.0 5853.0 1137.8 1170.8 1348.0 1357.9 1374.7 824.5 838.7 844.5 855.6 896.2 4601.6 4956.5 5007.6 5363.5 5367.5 5184.9 5918.7 5941.9 5959.4 5965.4 4548.3 4763.5 5043.6 5366.8 5380.7 2890.8 3013.8 3124.4 3143.9 3153.3 6111.4 6131.1 6165.8 6166.0 6220.8 5183.7 5290.3 6192.9 6222.8 6229.0 5015.4 5385.3 6255.4 6305.9 6344.5 5182.6 5947.3 5949.8 5982.2 6023.2 5464.3 5950.6 5965.6 5967.8 5995.0 5090.8 5768.4 6026.8 6242.4 6316.5 3687.8 3781.6 3905.9 3958.6 3970.4 5068.6 5131.6 5519.7 6014.9 6014.9 4134.9 5874.2 5907.3 5922.8 5934.6 4824.0 4899.3 5328.7 5664.6 5827.7 5033.9 5360.0 5488.3 5700.6 5713.8 5106.4 5632.4 5783.9 5796.0 5803.3 4598.9 4624.4 4827.1 4832.7 5344.4 14:54:51 INFO - PROCESS | 2372 | 14:54:51 INFO - PROCESS | 2372 | [#5] yui.html Cycles:180 Average:17431.04 Median:30528.02 stddev:24253.47 (79.4%) stddev-sans-first:24288.92 14:54:51 INFO - PROCESS | 2372 | Values: 686.3 695.3 700.7 717.5 718.4 14999.6 15269.6 15391.0 15456.1 15613.9 14319.9 14388.8 14405.9 14409.8 14420.8 872.5 893.5 920.3 923.8 934.3 910.3 930.2 933.7 938.5 942.3 970.6 972.8 975.3 975.4 976.3 956.2 960.7 962.4 966.5 969.7 709.8 715.1 722.7 723.5 724.0 15262.8 15330.5 15376.5 15384.4 15394.8 12203.3 12267.5 12453.4 12470.9 13100.9 8698.7 9660.6 9814.5 9872.1 10389.7 3934.7 4022.0 4061.0 4063.2 4209.4 74683.0 75537.9 75698.6 79386.2 81123.6 9223.4 9300.8 9337.7 9535.0 9618.1 20152.6 20257.1 20330.6 20367.0 20594.8 7055.6 7115.8 7149.4 7171.1 7481.0 3899.4 3907.9 3928.1 3929.9 3940.1 2947.4 3326.4 3327.6 3334.7 3348.4 610.7 612.3 626.8 627.4 638.6 513.6 517.6 525.7 552.5 566.9 7709.0 7814.9 7849.5 7915.5 8053.0 491.1 510.5 544.1 574.7 595.0 3754.9 3790.4 3818.9 3822.9 3833.6 65972.3 91303.5 92110.2 93039.5 93087.5 76643.0 77591.6 80451.6 80656.4 81063.6 65249.0 68026.0 68035.0 68113.0 69154.0 8035.0 8320.9 8450.8 8483.4 8493.4 31879.7 39579.0 41675.8 41925.0 43226.0 42693.8 58844.4 60461.1 60983.1 63003.7 10793.3 10844.5 11106.0 11329.7 11516.1 11835.8 11843.8 11876.3 11888.6 11955.8 11348.6 11451.9 11546.7 11670.6 11696.4 11353.5 11442.9 11614.1 11670.4 11869.4 11278.2 11296.0 11574.5 11596.1 11597.3 9510.0 9649.0 9661.5 9923.9 10117.3 8414.8 9366.5 9596.6 10087.9 10188.2 14:54:51 INFO - PROCESS | 2372 | -------- Summary: end -------- 14:54:51 INFO - PROCESS | 2372 | 14:54:52 INFO - TEST-INFO | 2372: exit 0 14:54:52 INFO - TEST-OK | dromaeo_css | took 1113461ms 14:54:52 INFO - TEST-START | kraken 14:54:52 INFO - operating with platform_type : mac_ 14:54:52 INFO - Initialising browser for kraken test... 14:54:52 INFO - TEST-INFO | started process 2376 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpr3ouxw/profile http://localhost:51515/getInfo.html) 14:54:55 INFO - PROCESS | 2376 | __metrics Screen width/height:1600/1200 14:54:55 INFO - PROCESS | 2376 | colorDepth:24 14:54:55 INFO - PROCESS | 2376 | Browser inner width/height: 1024/689 14:54:55 INFO - PROCESS | 2376 | __metrics 14:54:55 ERROR - PROCESS | 2376 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:54:56 INFO - TEST-INFO | 2376: exit 0 14:54:56 INFO - Browser initialized. 14:54:56 INFO - Running cycle 1/1 for kraken test... 14:54:56 INFO - TEST-INFO | started process 2379 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpr3ouxw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:08 INFO - PROCESS | 2379 | RSS: Main: 249978880 14:55:08 INFO - PROCESS | 2379 | 14:55:10 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51515/tests/kraken/driver.html?testName=audio-beat-detection) 14:55:11 INFO - PROCESS | 2379 | RSS: Main: 261726208 14:55:11 INFO - PROCESS | 2379 | 14:55:14 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51515/tests/kraken/driver.html?testName=audio-dft) 14:55:15 INFO - PROCESS | 2379 | RSS: Main: 267001856 14:55:15 INFO - PROCESS | 2379 | 14:55:18 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51515/tests/kraken/driver.html?testName=audio-fft) 14:55:19 INFO - PROCESS | 2379 | RSS: Main: 267272192 14:55:19 INFO - PROCESS | 2379 | 14:55:21 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51515/tests/kraken/driver.html?testName=audio-oscillator) 14:55:22 INFO - PROCESS | 2379 | RSS: Main: 267390976 14:55:22 INFO - PROCESS | 2379 | 14:55:24 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:55:24 INFO - PROCESS | 2379 | RSS: Main: 267988992 14:55:24 INFO - PROCESS | 2379 | 14:55:28 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51515/tests/kraken/driver.html?testName=imaging-darkroom) 14:55:28 INFO - PROCESS | 2379 | RSS: Main: 268636160 14:55:28 INFO - PROCESS | 2379 | 14:55:32 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51515/tests/kraken/driver.html?testName=imaging-desaturate) 14:55:32 INFO - PROCESS | 2379 | RSS: Main: 270163968 14:55:32 INFO - PROCESS | 2379 | 14:55:36 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51515/tests/kraken/driver.html?testName=json-parse-financial) 14:55:36 INFO - PROCESS | 2379 | RSS: Main: 271085568 14:55:36 INFO - PROCESS | 2379 | 14:55:38 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:55:39 INFO - PROCESS | 2379 | RSS: Main: 270049280 14:55:39 INFO - PROCESS | 2379 | 14:55:41 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51515/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:55:41 INFO - PROCESS | 2379 | RSS: Main: 270139392 14:55:41 INFO - PROCESS | 2379 | 14:55:44 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:55:44 INFO - PROCESS | 2379 | RSS: Main: 270704640 14:55:44 INFO - PROCESS | 2379 | 14:55:47 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:55:48 INFO - PROCESS | 2379 | RSS: Main: 270557184 14:55:48 INFO - PROCESS | 2379 | 14:55:51 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:55:52 INFO - PROCESS | 2379 | RSS: Main: 270544896 14:55:52 INFO - PROCESS | 2379 | 14:55:53 INFO - PROCESS | 2379 | Cycle 1(1): loaded http://localhost:51515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51515/tests/kraken/driver.html?testName=ai-astar) 14:55:54 INFO - PROCESS | 2379 | RSS: Main: 273395712 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | __start_tp_report 14:55:54 INFO - PROCESS | 2379 | _x_x_mozilla_page_load 14:55:54 INFO - PROCESS | 2379 | _x_x_mozilla_page_load_details 14:55:54 INFO - PROCESS | 2379 | |i|pagename|runs| 14:55:54 INFO - PROCESS | 2379 | |0;ai-astar;116;108;116;117;117;115;115;116;116;117 14:55:54 INFO - PROCESS | 2379 | |1;audio-beat-detection;165;112;179;254;156;168;164;120;183;122 14:55:54 INFO - PROCESS | 2379 | |2;audio-dft;195;200;214;212;196;197;198;199;203;224 14:55:54 INFO - PROCESS | 2379 | |3;audio-fft;72;83;76;182;85;48;72;86;163;85 14:55:54 INFO - PROCESS | 2379 | |4;audio-oscillator;83;81;136;82;121;118;157;98;83;124 14:55:54 INFO - PROCESS | 2379 | |5;imaging-gaussian-blur;111;88;135;81;123;131;106;87;89;98 14:55:54 INFO - PROCESS | 2379 | |6;imaging-darkroom;96;95;120;151;110;146;96;97;114;151 14:55:54 INFO - PROCESS | 2379 | |7;imaging-desaturate;123;121;125;150;151;90;93;92;91;90 14:55:54 INFO - PROCESS | 2379 | |8;json-parse-financial;59;59;59;60;60;61;60;121;61;57 14:55:54 INFO - PROCESS | 2379 | |9;json-stringify-tinderbox;66;70;68;74;77;73;71;68;71;71 14:55:54 INFO - PROCESS | 2379 | |10;stanford-crypto-aes;88;86;87;91;89;89;112;109;109;87 14:55:54 INFO - PROCESS | 2379 | |11;stanford-crypto-ccm;137;141;138;136;138;158;148;183;212;127 14:55:54 INFO - PROCESS | 2379 | |12;stanford-crypto-pbkdf2;171;168;168;169;169;168;168;168;168;164 14:55:54 INFO - PROCESS | 2379 | |13;stanford-crypto-sha256-iterative;67;67;63;64;66;60;64;71;68;66 14:55:54 INFO - PROCESS | 2379 | __end_tp_report 14:55:54 INFO - PROCESS | 2379 | __start_cc_report 14:55:54 INFO - PROCESS | 2379 | _x_x_mozilla_cycle_collect,1110 14:55:54 INFO - PROCESS | 2379 | __end_cc_report 14:55:54 INFO - PROCESS | 2379 | __startTimestamp1464040554040__endTimestamp 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | ------- Summary: start ------- 14:55:54 INFO - PROCESS | 2379 | Number of tests: 14 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:2.67 (2.3%) stddev-sans-first:2.82 14:55:54 INFO - PROCESS | 2379 | Values: 116.0 108.0 116.0 117.0 117.0 115.0 115.0 116.0 116.0 117.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#1] audio-beat-detection Cycles:10 Average:162.30 Median:166.50 stddev:41.02 (24.6%) stddev-sans-first:43.49 14:55:54 INFO - PROCESS | 2379 | Values: 165.0 112.0 179.0 254.0 156.0 168.0 164.0 120.0 183.0 122.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#2] audio-dft Cycles:10 Average:203.80 Median:201.50 stddev:9.64 (4.8%) stddev-sans-first:9.68 14:55:54 INFO - PROCESS | 2379 | Values: 195.0 200.0 214.0 212.0 196.0 197.0 198.0 199.0 203.0 224.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#3] audio-fft Cycles:10 Average:95.20 Median:79.50 stddev:42.49 (53.4%) stddev-sans-first:44.23 14:55:54 INFO - PROCESS | 2379 | Values: 72.0 83.0 76.0 182.0 85.0 48.0 72.0 86.0 163.0 85.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:81.50 stddev:26.80 (32.9%) stddev-sans-first:26.82 14:55:54 INFO - PROCESS | 2379 | Values: 83.0 81.0 136.0 82.0 121.0 118.0 157.0 98.0 83.0 124.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#5] imaging-gaussian-blur Cycles:10 Average:104.90 Median:84.00 stddev:19.52 (23.2%) stddev-sans-first:20.58 14:55:54 INFO - PROCESS | 2379 | Values: 111.0 88.0 135.0 81.0 123.0 131.0 106.0 87.0 89.0 98.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#6] imaging-darkroom Cycles:10 Average:117.60 Median:123.00 stddev:23.53 (19.1%) stddev-sans-first:23.62 14:55:54 INFO - PROCESS | 2379 | Values: 96.0 95.0 120.0 151.0 110.0 146.0 96.0 97.0 114.0 151.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#7] imaging-desaturate Cycles:10 Average:112.60 Median:90.00 stddev:24.73 (27.5%) stddev-sans-first:25.94 14:55:54 INFO - PROCESS | 2379 | Values: 123.0 121.0 125.0 150.0 151.0 90.0 93.0 92.0 91.0 90.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:60.00 stddev:19.47 (32.4%) stddev-sans-first:20.49 14:55:54 INFO - PROCESS | 2379 | Values: 59.0 59.0 59.0 60.0 60.0 61.0 60.0 121.0 61.0 57.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:3.21 (4.5%) stddev-sans-first:2.88 14:55:54 INFO - PROCESS | 2379 | Values: 66.0 70.0 68.0 74.0 77.0 73.0 71.0 68.0 71.0 71.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#10] stanford-crypto-aes Cycles:10 Average:94.70 Median:87.50 stddev:10.68 (12.2%) stddev-sans-first:11.05 14:55:54 INFO - PROCESS | 2379 | Values: 88.0 86.0 87.0 91.0 89.0 89.0 112.0 109.0 109.0 87.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:144.50 stddev:26.31 (18.2%) stddev-sans-first:27.36 14:55:54 INFO - PROCESS | 2379 | Values: 137.0 141.0 138.0 136.0 138.0 158.0 148.0 183.0 212.0 127.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.00 stddev:1.73 (1.0%) stddev-sans-first:1.48 14:55:54 INFO - PROCESS | 2379 | Values: 171.0 168.0 168.0 169.0 169.0 168.0 168.0 168.0 168.0 164.0 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - PROCESS | 2379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.50 stddev:3.03 (4.6%) stddev-sans-first:3.17 14:55:54 INFO - PROCESS | 2379 | Values: 67.0 67.0 63.0 64.0 66.0 60.0 64.0 71.0 68.0 66.0 14:55:54 INFO - PROCESS | 2379 | -------- Summary: end -------- 14:55:54 INFO - PROCESS | 2379 | 14:55:54 INFO - TEST-INFO | 2379: exit 0 14:55:54 INFO - TEST-OK | kraken | took 62454ms 14:55:54 INFO - SUITE-END | took 1175s 14:55:55 INFO - Completed test suite (00:19:36) 14:55:55 INFO - javascript benchmark 14:55:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7111.085600322781, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3499.895003149906, 3526.0832183632247, 3540.415831387821, 3545.2023294758683, 3570.8571657133716, 4743.715377077369, 5763.942360576399, 5839.795607153746, 5849.7367618457165, 5937.228160339156, 5755.280589926259, 5856.326522449919, 5861.560382971273, 5897.734601942912, 5975.701214939258, 5283.577313814895, 5331.840044798643, 5338.092524270884, 5414.214938833867, 5486.451354864522, 5503.20203570482, 5547.916781248285, 5557.221988921554, 5583.5254003409755, 5593.412691667378, 5256.264123022799, 5337.0, 5355.357357117171, 5368.865778355573, 5429.968306021863, 5339.172428273585, 5373.489518495737, 5377.81177658784, 5404.054290499147, 5440.972795136038, 5396.082665946798, 5402.91895621566, 5427.565794736412, 5446.074167391553, 5449.373322067973, 5493.752781124859, 5789.392113828072, 5791.594588378815, 5799.623024503394, 5858.209141765849, 6213.813585592439, 6218.533609979269, 6247.156633854417, 6271.278802937675, 6296.842578935518, 6208.782692605782, 6221.471174950089, 6259.217597800275, 6322.0200868865395, 6327.5570710050315, 4997.675151115239, 5950.553708471882, 6050.6974651267265, 6068.3021452533085, 6113.908291375633, 6453.903191452132, 6471.158749362553, 6474.223093228748, 6495.1231583736535, 6521.630457603861, 6125.662799505599, 6171.074338849208, 6215.9378406215355, 6285.088662143963, 6317.715702793385, 6342.080398342215, 6349.492040636738, 6361.395667411589, 6366.968165159237, 6372.6495042773095, 6129.754809807647, 6213.937860621426, 6262.530310226751, 6281.96859015702, 6283.842903927439, 6156.415140561639, 6191.535634827406, 6193.659348735863, 6235.906461403082, 6278.15244941927, 5052.343195384577, 5072.492750724972, 5085.211792172219, 5096.541311282002, 5138.820141295111, 4488.640908727294, 4572.565606267399, 4578.5650363215445, 4580.862574122782, 4628.83799067031, 5723.77104915807, 5880.558958078162, 5880.970595147082, 5990.311114221833, 6038.758449662052, 5320.787168513216, 6156.384361563897, 6157.599756015845, 6240.875182496325, 6278.30938596754, 5822.301323841166, 5851.531877449794, 5933.525317974551, 5940.138679891478, 5963.224780778471, 5434.782608695687, 5486.61593688438, 5504.889902201933, 5509.47659972302, 5521.806736764194, 6453.774117905851, 6490.870182596322, 6526.0, 6591.406773390418, 6597.175353080865, 6284.717187726655, 6293.937060629335, 6325.683715814283, 6346.524010699124, 6347.777827776005, 6329.778457753957, 6449.871002579828, 6612.5040621952585, 6625.966870165618, 6629.502787290876, 6192.040233763774, 6270.843228919313, 6273.435390814849, 6282.2147231596055, 6288.402601752826, 6235.376462353728, 6266.122742815918, 6282.371762823681, 6304.464120549805, 6366.713497892699, 6106.946079819441, 6156.476699480415, 6181.752729890754, 6270.372962703693, 6281.842953926189, 6197.349278325892, 6210.875782484235, 6272.937270627235, 6274.59215151032, 6281.026440901667, 5589.167386920215, 5678.0, 6056.454919057306, 6164.753409863734, 6203.96898015507, 6098.91636565712, 6155.815325540241, 6172.105044768573, 6234.189555357774, 6281.937180628135, 6174.104754810617, 6183.690815459119, 6183.721732522137, 6188.690565471618, 6212.161358216764], "value": 5823.699172705631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.4559547711086, 504.4803852032408, 514.927910092587, 538.4830562659846, 554.9528290095343, 31307.843460782693, 37910.81044594773, 38974.415383769265, 41055.0, 41087.17825643489, 38589.0, 39477.0, 42912.57087429125, 42949.78525107378, 43030.92422689434, 9535.284853635987, 9667.178289845371, 9670.226381889432, 9748.610055597768, 9752.0, 9607.039296070407, 9719.319647624669, 9739.561719722595, 9753.853692194623, 9783.412995220275, 8596.656133754643, 8717.779510868484, 9739.805203895918, 9760.511974401286, 9772.267079968995, 9664.951675241615, 9737.51312434379, 9742.561584728704, 9751.707448776513, 9764.365316254421, 9518.0, 9616.038396160398, 9622.0, 9653.662121825702, 9664.226861851035, 38631.80684096562, 38655.613443865484, 38698.41952370717, 38769.612303876886, 38832.41751373732, 3156.5580818685403, 3176.301213732975, 3234.4824828027636, 3419.4186988212064, 3597.334493118781, 27819.304517387023, 27935.0, 28182.0, 28403.71596284052, 28711.13866584006, 2676.357674158188, 2733.3439974406, 2745.5607102863446, 2856.371598248382, 2858.3425812063133, 502100.0, 507929.0, 508459.0, 508793.0, 509680.4515977433, 33966.81116160923, 62027.37972620216, 62437.0, 62464.37535624586, 62488.06267905985, 35210.8239458801, 35758.0, 36060.29547783927, 36208.0, 36215.63784362176, 14493.492727754478, 14895.0, 14927.776083358758, 14935.327910244065, 15032.699346013018, 12269.815952760715, 12327.445264963098, 12643.810342844865, 12701.93649031749, 12723.109382343147, 6718.731250750013, 7519.022527071445, 7914.564698941614, 7983.281504664492, 7991.800204994922, 3266.5590145330552, 3312.966870331266, 3316.966830331714, 3323.80057196569, 3340.1315657929113, 922.5525620074259, 931.5621657820814, 996.8554559588819, 1059.998301604976, 1089.7765957978595, 28174.43651126966, 29423.823047077876, 29684.703152968625, 29815.0, 30001.549976750368, 816.8774683797359, 940.5626383731598, 1147.5696613769837, 1167.258790667932, 1191.2018947305326, 15079.698406031817, 15199.468018619295, 15275.930684852176, 15506.84493155054, 15544.844551554566, 670698.0, 674700.0, 679987.0, 681367.0, 682240.0, 58509.4149058504, 59813.40186598165, 60232.0, 60357.698211508665, 60768.0, 1389.485890220625, 1401.5795261421736, 1448.0659974316718, 1450.5938337265582, 1456.0753921259864, 25713.614295785952, 26399.736002640497, 28900.566491503065, 29302.26744331409, 29351.70648293575, 50936.0, 51216.23175652443, 51616.48383516267, 51635.2254716172, 51670.74164629153, 596599.1020269399, 599578.0, 600166.0, 600810.0, 600825.0, 25995.870020649774, 26368.340791480365, 26436.0, 26653.86673066622, 26774.330641734112, 46119.077618448115, 46532.534674654176, 46768.36310729108, 47474.050518990116, 47517.76241118772, 37724.81137594295, 37995.43006854844, 38293.0, 38336.0, 38741.6125838738, 36253.0, 37507.0, 38176.618233818415, 38321.23357532889, 38329.33413317292, 31790.04629861108, 36300.729474468266, 37132.44301335536, 37629.247415052094, 37758.0, 29424.705752942198, 31563.89526366566, 33078.842240521466, 33562.0, 33924.812631557776, 23490.325191473163, 23864.880675596512, 24889.87555062213, 24970.37574060663, 25315.87342063278], "value": 18479.073936441062, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.5194460254222, 375.83087610575245, 382.20882772660593, 382.4912865888368, 404.92711311963836, 19719.11263993122, 19889.701654475193, 20767.169313227452, 21002.15991360344, 21015.36953891382, 10068.395896246231, 11704.941475292633, 11748.0, 12295.877041229585, 12296.077794165429, 4854.805807767685, 5249.606279529041, 5414.620976531644, 5446.1558458439, 5448.42791506892, 3869.9806500967456, 5771.971140144294, 6090.299615544202, 6103.87792244157, 6183.87632247357, 5924.140999555062, 6055.788047418341, 6136.23297087864, 6147.60040597362, 6170.074488826667, 5964.1650168976375, 6014.729337179816, 6026.758929642809, 6081.422264884829, 6092.969535152318, 5140.331756871583, 5535.169724541311, 5547.057000309957, 5804.970975145139, 5806.0, 22357.0, 24999.12503062402, 25243.368915777068, 25547.105851295302, 25705.97176112953, 2138.2409244718056, 2185.115028413479, 2283.760205178449, 2331.49872777352, 2654.3554562859035, 9557.235421166359, 9766.267529935212, 10173.694789156338, 10196.286259961806, 13288.468461261538, 1613.3869129730745, 1616.9110698911554, 1689.3073839725776, 1720.2946791815295, 1828.6799810033324, 97119.0, 105270.42094368591, 119536.0, 119927.4003629985, 122225.0, 11488.827667584992, 11689.76620467586, 11820.468078936468, 11845.170838041255, 11922.401054355234, 14642.341094650767, 14672.559823205322, 14681.632959176106, 14701.779473307908, 14762.557123286319, 8625.956870215734, 8682.044975052739, 8734.694285700098, 8753.0, 8780.078091800397, 7141.678624461912, 8460.746177614681, 8599.183077607617, 8696.565171741388, 8709.129087091367, 4057.736247143926, 4425.712328698624, 4426.782634775463, 4556.0, 4574.062317224961, 1590.3877007352253, 1837.5865430278348, 1921.8942958137156, 1963.0675429171315, 1970.5566247594177, 858.9214101873481, 872.6204101215991, 937.1846493550654, 938.6902322233647, 985.1626117799956, 19389.709154362696, 20114.69827952582, 20180.39458816238, 20222.898885505772, 20365.79634203639, 913.8903331600118, 937.6249500199974, 946.4084946908182, 968.4915419404728, 973.3721749471551, 8535.658573656985, 10507.527161277761, 10718.624848130434, 10731.83902241467, 10794.974477424632, 603161.0, 608008.0, 613236.933815328, 613536.0, 619366.0, 132001.0, 135516.0, 137404.0, 140508.0, 142488.5751142496, 1000.7698229407277, 1009.9596016159418, 1028.2596530498029, 1033.565902321012, 1038.2835843268272, 13738.519151829638, 14359.210243436712, 17692.82307176963, 17842.821571784116, 17892.0, 49319.013619726684, 50126.74936625294, 52129.739351303004, 53148.0, 53375.733121334146, 60585.0, 72264.0, 75775.62112189404, 76176.0, 77548.2245177541, 8019.518828870287, 8051.275385215359, 8088.150744171778, 8171.795705107182, 8192.795180120307, 10614.310069845435, 11505.194636375709, 12328.691782705504, 12549.184303020274, 12632.74734505323, 9189.127032931861, 10144.391336519833, 10644.095251903675, 10820.837687434852, 10942.890571094187, 9294.0, 10542.683719488428, 10652.520636571528, 10810.783784324112, 10939.0, 10184.745381365525, 10572.259941803999, 10931.508082136483, 11385.975262226439, 11529.308241505536, 8123.5532045738055, 8145.918540814753, 8185.549794761345, 8307.626156822836, 8531.061583225715, 8945.776355591162, 10401.0, 10626.89373106259, 11050.281731687415, 11134.777304454028], "value": 9246.728805209688, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.2136489025706, 1535.009918602501, 1817.1368599915043, 1944.4847115514392, 1986.503374156461, 8127.390445716565, 8716.389852710305, 8784.51685157316, 9233.815323693521, 9236.399634023785, 7588.962055189731, 8820.691275805348, 8864.734057978254, 9025.819483610323, 9048.819023619524, 2370.9051637934504, 2417.830751847371, 2418.673479080328, 2418.891149898259, 2421.515696860626, 2357.1867705641525, 2412.445137618349, 2416.4683769570665, 2434.2697190842678, 2440.6095024796036, 1981.821636052755, 2423.75762423758, 2426.357015390914, 2431.720352159498, 2432.902683892642, 1970.7733610634816, 2009.447401964457, 2387.510560335127, 2390.8924098415528, 2413.4207790130417, 2363.929082127539, 2368.01727283179, 2387.877697482181, 2389.474315650554, 2391.4021494626345, 8934.017258101603, 8943.731688049369, 9021.188093071654, 9027.774305642346, 9055.81888362229, 5323.201519772027, 5418.539424148952, 5491.7254137292975, 5503.972480137613, 5509.9255645149215, 3054.9541756873664, 3184.5541624172633, 3319.468884978392, 3546.2198316370614, 3547.7161827053774, 1020.9081182693519, 1030.5259580592935, 1031.0771859185986, 1037.444966942682, 1039.6101461951769, 11834.822477662756, 11888.762224755457, 11961.940190298992, 11997.280163190237, 12030.69923251917, 4809.158397280532, 4832.323474713543, 4856.635752318591, 4868.099401610713, 4905.9264111038365, 9996.050375214343, 10096.141827944706, 10189.490525473697, 10206.489675516195, 10234.795304093876, 5389.784408623689, 5405.0, 5406.972965135228, 5445.53712934405, 5447.754851031713, 4484.753338566345, 4862.586680132157, 4946.8763280918265, 5033.0, 5035.16919708244, 4023.8994025149605, 4051.7771522565954, 4121.155163191538, 4134.565870583606, 4178.561251068594, 1293.7606542789426, 1301.9544315948897, 1315.1780137414116, 1316.7169058652435, 1317.7101037771674, 691.5781373362245, 897.4032268541347, 925.1904583489446, 937.3719607862748, 945.6595625574788, 5312.389075256395, 5804.767809287666, 5956.6723830188885, 6089.238845144357, 6120.051392034242, 918.0589895357178, 934.3926447808979, 941.9011003844635, 951.7382719751985, 952.2905435450633, 3833.9041523961564, 3932.783696896698, 3951.604839516083, 3992.7604343739467, 4013.097053163015, 10422.947885260677, 10667.626633067805, 10811.83782243267, 10816.67549973502, 10891.292066015683, 9197.540122993823, 10571.524281407355, 10881.673549793519, 10937.179711521667, 10943.83584246237, 8181.3863960203225, 8406.705765298308, 8410.369222308229, 8420.452670576393, 8455.957720211483, 5776.595638305446, 5860.677662728591, 6062.120992456157, 6066.484348830399, 6183.81448556544, 9837.803243935225, 9896.406215627085, 10172.745681358025, 10199.337043092175, 10200.744981375525, 10011.699649010541, 10148.746281343025, 10175.084242418217, 10369.0, 10383.53274102652, 6784.898226526508, 6993.930060699327, 7505.099388073466, 7640.159582445815, 7666.386689064973, 8373.33013358942, 8436.409451338348, 8466.619002145042, 8473.195046470575, 8519.318454523747, 7380.261973802577, 7485.1766305707415, 7526.5860377679755, 7618.6190690466365, 7627.5042122261875, 7357.668904899399, 7401.592912389655, 7431.8142046449275, 7500.287472690085, 7510.849783004419, 6932.237453879969, 6988.720451182099, 6994.965025175045, 6998.720051198099, 6999.860002799814, 4761.262004389325, 4808.639352048541, 4904.2643603459765, 4953.702777833341, 5063.898722025465, 3759.7368184226843, 4151.3772934058925, 4928.457869634266, 5041.924371134362, 5172.793088276427], "value": 4617.74047438939, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.9140640620626, 307.63852473343815, 310.63810660580424, 313.1935266688278, 315.4574132492113, 5530.5022547970675, 5569.498745112939, 5610.232776675344, 5664.801731939383, 5675.6878371689545, 5489.478499542547, 5489.972550137254, 5544.473275038875, 5549.417311182328, 5567.693776842272, 3505.4216054351, 3982.1836523512684, 4074.8166332515107, 4187.28816101262, 4196.895077623069, 4133.979330103345, 4169.0, 4178.644815190697, 4201.6008479194425, 4206.263903816835, 3288.6546912574195, 3401.812900290483, 4148.771817550049, 4150.937735933963, 4184.727992680466, 3480.9477857832153, 3530.735194860396, 4052.6555242804397, 4091.7340372875965, 4127.36025915982, 3404.8889688393106, 3496.6712649193396, 3545.4150065239205, 3559.5728512578658, 3570.4111670306725, 4714.96270820419, 5098.4646612105935, 5320.244319374636, 5321.973390133025, 5356.625036247464, 4358.629516491102, 4574.9521370496595, 4644.489106198315, 4707.552782485658, 4750.358701575277, 5067.619928505377, 5412.269343638637, 5765.500969747854, 5799.506212328697, 5801.564882633819, 3078.630564332272, 3903.960960390388, 3907.316219661548, 3927.6465118139504, 3987.983064318609, 5341.599380046512, 5830.883382332329, 5858.3848695886745, 5943.3462319144855, 6019.036954087369, 3205.9198520037185, 3936.9212615747524, 3965.960340396559, 3973.7019723520852, 3977.5226972763453, 3547.450145227494, 4006.699497537638, 4012.29784787661, 4021.859234926822, 4023.1551374211745, 4194.119234960693, 4424.911501769947, 4659.95340046602, 4687.929681054787, 4692.554207350297, 5098.770555325019, 5404.513593776579, 5817.3019237690905, 5847.0, 5853.0, 1137.7895089408487, 1170.7716995185856, 1347.995743171324, 1357.891368690522, 1374.731927274192, 824.5052968219021, 838.6687258532967, 844.5059640110604, 855.5978690015808, 896.2068569316202, 4601.585857272861, 4956.529129732669, 5007.574356179693, 5363.517283444431, 5367.530935769511, 5184.870378240575, 5918.733656985446, 5941.940580594139, 5959.404059594006, 5965.403459654, 4548.2722764358205, 4763.476017638057, 5043.646944713908, 5366.838994830161, 5380.650257733235, 2890.783191260664, 3013.819170849756, 3124.4063627911078, 3143.858526366319, 3153.274746808201, 6111.35830737775, 6131.099359198663, 6165.8458538536, 6165.961295351552, 6220.782272620437, 5183.740812959337, 5290.259363689087, 6192.907106393408, 6222.751089956351, 6229.034499652561, 5015.448300686921, 5385.272988146628, 6255.437010669061, 6305.896468118061, 6344.492440604833, 5182.579497531611, 5947.3457919627945, 5949.791757288474, 5982.162497250475, 6023.216981792339, 5464.3442786865835, 5950.613210141327, 5965.552583556338, 5967.8209653710455, 5995.0, 5090.796368145233, 5768.394318596487, 6026.849328766816, 6242.406971337716, 6316.494680425463, 3687.797171155612, 3781.6029316922427, 3905.863294784669, 3958.5645578986864, 3970.4441378207653, 5068.619853510928, 5131.640785145004, 5519.668819870821, 6014.879702406015, 6014.939915556894, 4134.937975930424, 5874.236349274567, 5907.32065812437, 5922.822315330547, 5934.575701831443, 4823.95176048235, 4899.289603007615, 5328.706921119376, 5664.603477756682, 5827.70861456917, 5033.874153146201, 5360.0, 5488.25908502363, 5700.572457065819, 5713.828825002163, 5106.387233532, 5632.352794186726, 5783.8554036149435, 5795.971020144872, 5803.274590676166, 4598.91872445469, 4624.375709279204, 4827.08285425768, 4832.661713680009, 5344.438833922382], "value": 4151.085977983612, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.3273991488342, 695.3429009585943, 700.737223541172, 717.5264325545139, 718.357070421972, 14999.625009374771, 15269.61825954349, 15391.0, 15456.072635641869, 15613.907026508148, 14319.856801431983, 14388.784168237486, 14405.855941440583, 14409.78385324221, 14420.783688244685, 872.4590753732679, 893.4817805672727, 920.2591913509622, 923.7736754495124, 934.3226161033265, 910.3263584947125, 930.1675000874247, 933.6965486216973, 938.4932136646203, 942.2979879989417, 970.6457143142773, 972.7859870828406, 975.2588033094863, 975.4098770243971, 976.2970661124015, 956.2350119904049, 960.6637676813094, 962.4417837654144, 966.4781018250136, 969.6606187834237, 709.7586820481062, 715.0632671200692, 722.7036914864933, 723.4646361692362, 724.0298000679063, 15262.771058434133, 15330.540083797503, 15376.461823836113, 15384.384624615002, 15394.769078463833, 12203.3392963625, 12267.509299628004, 12453.439595218237, 12470.875291247154, 13100.934495327558, 8698.695545655872, 9660.613575456973, 9814.509274536245, 9872.062154095349, 10389.740256493573, 3934.7048971327263, 4022.0198857119935, 4060.979695101535, 4063.227986682521, 4209.389638502431, 74683.0, 75537.86693199606, 75698.62150689212, 79386.20613793845, 81123.5943820283, 9223.44659320443, 9300.767480812898, 9337.673181438617, 9534.95232523833, 9618.134367906921, 20152.59694806125, 20257.08843102064, 20330.593388132154, 20367.0, 20594.794052059588, 7055.576665400093, 7115.786526404217, 7149.428045756327, 7171.067761191011, 7481.0, 3899.395593682984, 3907.9218415631526, 3928.096537796323, 3929.941050884239, 3940.1134744682217, 2947.3957838643028, 3326.434506133963, 3327.584051993501, 3334.733221342287, 3348.363810875926, 610.6610830988755, 612.2561088277675, 626.837022374186, 627.3914303125961, 638.6104476269472, 513.5634710496048, 517.6428264497484, 525.6805418399844, 552.499987511303, 566.8922904648103, 7708.961455192688, 7814.882776758353, 7849.529028258208, 7915.525068495794, 8053.033635963605, 491.0945875843016, 510.50812442890805, 544.0777881490914, 574.6982834012177, 594.9524038076944, 3754.9436758448646, 3790.3935370340614, 3818.9236215275537, 3822.8853134406013, 3833.5974722654278, 65972.34027659662, 91303.54348228217, 92110.15779684369, 93039.53480232555, 93087.53456232675, 76643.0, 77591.61204193943, 80451.59774201091, 80656.38687226223, 81063.59468202622, 65249.0, 68026.0, 68034.99999999901, 68113.0, 69154.0, 8035.035795704553, 8320.916790832014, 8450.788730281793, 8483.44857584255, 8493.405461617875, 31879.681203187673, 39579.0, 41675.7916210417, 41925.0, 43226.0, 42693.78653106715, 58844.41155588561, 60461.09308360466, 60983.085253722114, 63003.6849815748, 10793.29843560166, 10844.457777110954, 11106.0, 11329.660110196708, 11516.078713703051, 11835.763284734428, 11843.822342664695, 11876.287422754662, 11888.643340699793, 11955.820662690241, 11348.602798901999, 11451.885481145415, 11546.711332216762, 11670.591529296773, 11696.415179240834, 11353.48909299067, 11442.942785286354, 11614.128940329678, 11670.358130302575, 11869.40652967331, 11278.210525263154, 11296.0, 11574.47914843851, 11596.072314215011, 11597.304161750322, 9509.952450237704, 9649.035096490295, 9661.526777059527, 9923.851142232728, 10117.342372745748, 8414.83170336602, 9366.531673416166, 9596.625362509987, 10087.949560252151, 10188.184945204217], "value": 6778.218980118039, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1636.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 116.0, 117.0, 117.0, 115.0, 115.0, 116.0, 116.0, 117.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 112.0, 179.0, 254.0, 156.0, 168.0, 164.0, 120.0, 183.0, 122.0], "value": 162.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 200.0, 214.0, 212.0, 196.0, 197.0, 198.0, 199.0, 203.0, 224.0], "value": 203.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 83.0, 76.0, 182.0, 85.0, 48.0, 72.0, 86.0, 163.0, 85.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 136.0, 82.0, 121.0, 118.0, 157.0, 98.0, 83.0, 124.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 88.0, 135.0, 81.0, 123.0, 131.0, 106.0, 87.0, 89.0, 98.0], "value": 104.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 120.0, 151.0, 110.0, 146.0, 96.0, 97.0, 114.0, 151.0], "value": 117.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 125.0, 150.0, 151.0, 90.0, 93.0, 92.0, 91.0, 90.0], "value": 112.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 61.0, 60.0, 121.0, 61.0, 57.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 68.0, 74.0, 77.0, 73.0, 71.0, 68.0, 71.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 91.0, 89.0, 89.0, 112.0, 109.0, 109.0, 87.0], "value": 94.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 141.0, 138.0, 136.0, 138.0, 158.0, 148.0, 183.0, 212.0, 127.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 168.0, 169.0, 169.0, 168.0, 168.0, 168.0, 168.0, 164.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 63.0, 64.0, 66.0, 60.0, 64.0, 71.0, 68.0, 66.0], "value": 65.6, "unit": "score"}]}]} 14:55:55 INFO - Return code: 0 14:55:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:55:55 ERROR - # TBPL SUCCESS # 14:55:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:55:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:55:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:55:55 INFO - 2016-05-23 14:55:55.373 screenresolution[2384:22189] starting screenresolution argv=screenresolution get 14:55:55 INFO - 2016-05-23 14:55:55.376 screenresolution[2384:22189] Display 0: 1600x1200x32@60 14:55:55 INFO - 2016-05-23 14:55:55.383 screenresolution[2385:22192] starting screenresolution argv=screenresolution list 14:55:55 INFO - Available Modes on Display 0 14:55:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:55:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:55:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:55:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:55:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:55:55 INFO - Intel Iris: 14:55:55 INFO - Chipset Model: Intel Iris 14:55:55 INFO - Type: GPU 14:55:55 INFO - Bus: Built-In 14:55:55 INFO - VRAM (Dynamic, Max): 1536 MB 14:55:55 INFO - Vendor: Intel (0x8086) 14:55:55 INFO - Device ID: 0x0a2e 14:55:55 INFO - Revision ID: 0x0009 14:55:55 INFO - Displays: 14:55:55 INFO - Display: 14:55:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:55:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:55:55 INFO - Display Serial Number: 1600x1200 60 14:55:55 INFO - Main Display: Yes 14:55:55 INFO - Mirror: Off 14:55:55 INFO - Online: Yes 14:55:55 INFO - Rotation: Supported 14:55:55 INFO - Return code: 0 14:55:55 INFO - Running post-action listener: _resource_record_post_action 14:55:55 INFO - ##### 14:55:55 INFO - ##### Finished run-tests step (success) 14:55:55 INFO - ##### 14:55:55 INFO - Running post-run listener: _resource_record_post_run 14:55:55 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 630784; Write bytes: 702471680; Read time: 7; Write time: 1966 14:55:55 INFO - TinderboxPrint: CPU usage
54.2% 14:55:55 INFO - TinderboxPrint: I/O read bytes / time
630,784 / 7 14:55:55 INFO - TinderboxPrint: I/O write bytes / time
702,471,680 / 1,966 14:55:55 INFO - TinderboxPrint: CPU idle
2,221.6 (45.8%) 14:55:55 INFO - TinderboxPrint: CPU system
976.3 (20.1%) 14:55:55 INFO - TinderboxPrint: CPU user
1,647.9 (34.0%) 14:55:55 INFO - TinderboxPrint: Swap in / out
396,849,152 / 0 14:55:55 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 375448064; Write bytes: 374004736; Read time: 28116; Write time: 760 14:55:55 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 520192; Write bytes: 298735104; Read time: 3; Write time: 1143 14:55:56 INFO - Running post-run listener: _upload_blobber_files 14:55:56 INFO - Blob upload gear active. 14:55:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:55:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:55:56 INFO - (blobuploader) - INFO - Open directory for files ... 14:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:55:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:57 INFO - (blobuploader) - INFO - Done attempting. 14:55:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:55:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:55:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:58 INFO - (blobuploader) - INFO - Done attempting. 14:55:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:55:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:56:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:56:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:56:01 INFO - (blobuploader) - INFO - Done attempting. 14:56:01 INFO - (blobuploader) - INFO - Iteration through files over. 14:56:01 INFO - Return code: 0 14:56:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:56:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:56:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02e032587796ddaa1d5f35b440495b5b5cf01feb640f22c37a24ff731e15a219c0c70d375c341cc0b26a15accc788d2a80456443e344ef033faffd66cca4ef23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1de0bf69a99a5207c074b750cdbbdae26357283f4e2994d7a5cc91ae40c1333066447b7ba78fbbf0efd91cf27a712e186ad5efc93212a2f45f29b94ebb5d7391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c20f4b2cd3d7966f9e1158056bfbf0d9d077ebf08d5133350d0059ddba66dc6d8e7257b7c241dead3277cb00faf6df5f9fcdc98b026be2dfd4b492ced048a82"} 14:56:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:56:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:56:01 INFO - Contents: 14:56:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02e032587796ddaa1d5f35b440495b5b5cf01feb640f22c37a24ff731e15a219c0c70d375c341cc0b26a15accc788d2a80456443e344ef033faffd66cca4ef23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1de0bf69a99a5207c074b750cdbbdae26357283f4e2994d7a5cc91ae40c1333066447b7ba78fbbf0efd91cf27a712e186ad5efc93212a2f45f29b94ebb5d7391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c20f4b2cd3d7966f9e1158056bfbf0d9d077ebf08d5133350d0059ddba66dc6d8e7257b7c241dead3277cb00faf6df5f9fcdc98b026be2dfd4b492ced048a82"} 14:56:01 INFO - Running post-run listener: copy_logs_to_upload_dir 14:56:01 INFO - Copying logs to upload dir... 14:56:01 INFO - mkdir: /builds/slave/test/build/upload/logs 14:56:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.609512 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-05-23 14:56:01.642768) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 14:56:01.646702) ========= 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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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/02e032587796ddaa1d5f35b440495b5b5cf01feb640f22c37a24ff731e15a219c0c70d375c341cc0b26a15accc788d2a80456443e344ef033faffd66cca4ef23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1de0bf69a99a5207c074b750cdbbdae26357283f4e2994d7a5cc91ae40c1333066447b7ba78fbbf0efd91cf27a712e186ad5efc93212a2f45f29b94ebb5d7391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c20f4b2cd3d7966f9e1158056bfbf0d9d077ebf08d5133350d0059ddba66dc6d8e7257b7c241dead3277cb00faf6df5f9fcdc98b026be2dfd4b492ced048a82"} build_url:https://queue.taskcluster.net/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011062 build_url: 'https://queue.taskcluster.net/v1/task/IYr2NLyURuajldZr-yH0_w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02e032587796ddaa1d5f35b440495b5b5cf01feb640f22c37a24ff731e15a219c0c70d375c341cc0b26a15accc788d2a80456443e344ef033faffd66cca4ef23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1de0bf69a99a5207c074b750cdbbdae26357283f4e2994d7a5cc91ae40c1333066447b7ba78fbbf0efd91cf27a712e186ad5efc93212a2f45f29b94ebb5d7391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c20f4b2cd3d7966f9e1158056bfbf0d9d077ebf08d5133350d0059ddba66dc6d8e7257b7c241dead3277cb00faf6df5f9fcdc98b026be2dfd4b492ced048a82"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 14:56:01.678617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:56:01.679229) ========= 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.GL7oBZ4Det/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.RymMtJi1Cw/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.005431 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:56:01.728114) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 14:56:01.728467) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 14:56:01.728926) ========= ========= Total master_lag: 0.21 =========