builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0075 starttime: 1459773000.28 results: success (0) buildid: 20160404032320 builduid: b2e60f1860704f5c936d50cd634994bd revision: 6fc436f9db859d961581a5f27bbb69731679f593 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:00.281414) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:00.281824) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2016-04-04 05:30:00.282121) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7LgIShoPLf/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.6wY9VoSV0G/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005541 basedir: '/builds/slave/test' ========= master_lag: 4.62 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2016-04-04 05:30:04.907760) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:04.908042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:05.047965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:05.048207) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7LgIShoPLf/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.6wY9VoSV0G/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005672 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:05.103088) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:05.103344) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:05.103658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:05.103940) ========= 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.7LgIShoPLf/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.6wY9VoSV0G/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-04 05:30:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.9M=0.001s 2016-04-04 05:30:05 (12.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113797 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:05.463872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:05.464145) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7LgIShoPLf/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.6wY9VoSV0G/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.026264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:05.516046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 05:30:05.516687) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6fc436f9db859d961581a5f27bbb69731679f593 --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 6fc436f9db859d961581a5f27bbb69731679f593 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7LgIShoPLf/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.6wY9VoSV0G/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-04 05:30:05,598 truncating revision to first 12 chars 2016-04-04 05:30:05,598 Setting DEBUG logging. 2016-04-04 05:30:05,598 attempt 1/10 2016-04-04 05:30:05,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6fc436f9db85?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 05:30:06,607 unpacking tar archive at: fx-team-6fc436f9db85/testing/mozharness/ program finished with exit code 0 elapsedTime=1.256457 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-04 05:30:06.790812) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:06.794207) ========= echo 6fc436f9db859d961581a5f27bbb69731679f593 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6fc436f9db859d961581a5f27bbb69731679f593'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7LgIShoPLf/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.6wY9VoSV0G/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 6fc436f9db859d961581a5f27bbb69731679f593 program finished with exit code 0 elapsedTime=0.005492 script_repo_revision: '6fc436f9db859d961581a5f27bbb69731679f593' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:06.846741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:06.847089) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 05:30:06.877436) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-04 05:30:06.877755) ========= /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.7LgIShoPLf/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.6wY9VoSV0G/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:30:07 INFO - MultiFileLogger online at 20160404 05:30:07 in /builds/slave/test 05:30:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:30:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:30:07 INFO - {'append_to_log': False, 05:30:07 INFO - 'base_work_dir': '/builds/slave/test', 05:30:07 INFO - 'blob_upload_branch': 'Fx-Team', 05:30:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:30:07 INFO - 'branch': 'Fx-Team', 05:30:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:30:07 INFO - 'config_files': ('talos/mac_config.py',), 05:30:07 INFO - 'default_actions': ('clobber', 05:30:07 INFO - 'read-buildbot-config', 05:30:07 INFO - 'download-and-extract', 05:30:07 INFO - 'populate-webroot', 05:30:07 INFO - 'create-virtualenv', 05:30:07 INFO - 'install', 05:30:07 INFO - 'run-tests'), 05:30:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:30:07 INFO - 'download_minidump_stackwalk': True, 05:30:07 INFO - 'download_symbols': 'ondemand', 05:30:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:30:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:30:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:30:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:30:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:30:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:30:07 INFO - 'installer_path': 'installer.exe', 05:30:07 INFO - 'log_level': 'info', 05:30:07 INFO - 'log_name': 'talos', 05:30:07 INFO - 'log_to_console': True, 05:30:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:30:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:30:07 INFO - 'opt_config_files': (), 05:30:07 INFO - 'pip_index': False, 05:30:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:30:07 INFO - 'cmd': ('bash', 05:30:07 INFO - '-c', 05:30:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:30:07 INFO - 'enabled': True, 05:30:07 INFO - 'halt_on_failure': False, 05:30:07 INFO - 'name': 'check_screen_resolution'},), 05:30:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:30:07 INFO - 'cmd': ('bash', 05:30:07 INFO - '-c', 05:30:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:30:07 INFO - 'enabled': True, 05:30:07 INFO - 'halt_on_failure': False, 05:30:07 INFO - 'name': 'check_screen_resolution'},), 05:30:07 INFO - 'run_cmd_checks_enabled': True, 05:30:07 INFO - 'sps_profile': False, 05:30:07 INFO - 'sps_profile_interval': 0, 05:30:07 INFO - 'suite': 'dromaeojs-e10s', 05:30:07 INFO - 'system_bits': '32', 05:30:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:30:07 INFO - 'title': 't-yosemite-r7-0075', 05:30:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:30:07 INFO - 'use_talos_json': True, 05:30:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:30:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:30:07 INFO - 'work_dir': 'build'} 05:30:07 INFO - ##### 05:30:07 INFO - ##### Running clobber step. 05:30:07 INFO - ##### 05:30:07 INFO - Running pre-action listener: _resource_record_pre_action 05:30:07 INFO - Running main action method: clobber 05:30:07 INFO - rmtree: /builds/slave/test/build 05:30:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:30:08 INFO - Running post-action listener: _resource_record_post_action 05:30:08 INFO - ##### 05:30:08 INFO - ##### Running read-buildbot-config step. 05:30:08 INFO - ##### 05:30:08 INFO - Running pre-action listener: _resource_record_pre_action 05:30:08 INFO - Running main action method: read_buildbot_config 05:30:08 INFO - Using buildbot properties: 05:30:08 INFO - { 05:30:08 INFO - "project": "", 05:30:08 INFO - "product": "firefox", 05:30:08 INFO - "script_repo_revision": "production", 05:30:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:30:08 INFO - "repository": "", 05:30:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:30:08 INFO - "buildid": "20160404032320", 05:30:08 INFO - "pgo_build": "False", 05:30:08 INFO - "basedir": "/builds/slave/test", 05:30:08 INFO - "buildnumber": 585, 05:30:08 INFO - "slavename": "t-yosemite-r7-0075", 05:30:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:30:08 INFO - "platform": "yosemite_r7", 05:30:08 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:30:08 INFO - "branch": "fx-team", 05:30:08 INFO - "repo_path": "integration/fx-team", 05:30:08 INFO - "revision": "6fc436f9db859d961581a5f27bbb69731679f593", 05:30:08 INFO - "stage_platform": "macosx64", 05:30:08 INFO - "builduid": "b2e60f1860704f5c936d50cd634994bd", 05:30:08 INFO - "slavebuilddir": "test" 05:30:08 INFO - } 05:30:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:30:08 INFO - Running post-action listener: _resource_record_post_action 05:30:08 INFO - ##### 05:30:08 INFO - ##### Running download-and-extract step. 05:30:08 INFO - ##### 05:30:08 INFO - Running pre-action listener: _resource_record_pre_action 05:30:08 INFO - Running main action method: download_and_extract 05:30:08 INFO - mkdir: /builds/slave/test/build/tests 05:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:08 INFO - https://queue.taskcluster.net/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:30:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:30:10 INFO - Downloaded 1199 bytes. 05:30:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:10 INFO - Using the following test package requirements: 05:30:10 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:30:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:10 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:30:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:10 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:30:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:10 INFO - u'jsshell-mac.zip'], 05:30:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:10 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:30:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:30:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:10 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:30:10 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:10 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:30:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:10 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:30:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:10 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:30:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:10 INFO - https://queue.taskcluster.net/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:30:11 INFO - Downloaded 17959648 bytes. 05:30:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:30:14 INFO - Return code: 0 05:30:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:14 INFO - https://queue.taskcluster.net/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:30:16 INFO - Downloaded 17959648 bytes. 05:30:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:30:19 INFO - Return code: 0 05:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:19 INFO - https://queue.taskcluster.net/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:30:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:30:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:30:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:30:20 INFO - Downloaded 10847584 bytes. 05:30:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:30:21 INFO - Return code: 0 05:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:21 INFO - https://queue.taskcluster.net/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:30:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:30:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:30:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:30:27 INFO - Downloaded 111245168 bytes. 05:30:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:30:27 INFO - mkdir: /builds/slave/test/properties 05:30:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:30:27 INFO - Writing to file /builds/slave/test/properties/build_url 05:30:27 INFO - Contents: 05:30:27 INFO - build_url:https://queue.taskcluster.net/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:30:28 INFO - Running post-action listener: _resource_record_post_action 05:30:28 INFO - Running post-action listener: set_extra_try_arguments 05:30:28 INFO - ##### 05:30:28 INFO - ##### Running populate-webroot step. 05:30:28 INFO - ##### 05:30:28 INFO - Running pre-action listener: _resource_record_pre_action 05:30:28 INFO - Running main action method: populate_webroot 05:30:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:28 INFO - '--tppagecycles', 05:30:28 INFO - '7'], 05:30:28 INFO - 'tests': ['tsvgm']}}, 05:30:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:30:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:30:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:30:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:30:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:30:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:28 INFO - 'talos_options': ['--e10s'], 05:30:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:28 INFO - 'tests': ['damp', 'tps']}, 05:30:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:28 INFO - 'talos_options': ['--e10s'], 05:30:28 INFO - 'tests': ['damp', 'tps']}, 05:30:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:30:28 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 05:30:28 INFO - 'tests': ['dromaeo_dom']}, 05:30:28 INFO - 'other': {'tests': ['a11yr', 05:30:28 INFO - 'ts_paint', 05:30:28 INFO - 'tpaint', 05:30:28 INFO - 'sessionrestore', 05:30:28 INFO - 'sessionrestore_no_auto_restore', 05:30:28 INFO - 'tabpaint']}, 05:30:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:30:28 INFO - 'tests': ['a11yr', 05:30:28 INFO - 'ts_paint', 05:30:28 INFO - 'tpaint', 05:30:28 INFO - 'sessionrestore', 05:30:28 INFO - 'sessionrestore_no_auto_restore', 05:30:28 INFO - 'tabpaint']}, 05:30:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:30:28 INFO - 'tests': ['a11yr', 05:30:28 INFO - 'ts_paint', 05:30:28 INFO - 'tpaint', 05:30:28 INFO - 'sessionrestore', 05:30:28 INFO - 'sessionrestore_no_auto_restore', 05:30:28 INFO - 'tabpaint']}, 05:30:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:30:28 INFO - 'tests': ['a11yr', 05:30:28 INFO - 'ts_paint', 05:30:28 INFO - 'tpaint', 05:30:28 INFO - 'sessionrestore', 05:30:28 INFO - 'sessionrestore_no_auto_restore', 05:30:28 INFO - 'tabpaint']}, 05:30:28 INFO - 'other_l64': {'tests': ['a11yr', 05:30:28 INFO - 'ts_paint', 05:30:28 INFO - 'tpaint', 05:30:28 INFO - 'sessionrestore', 05:30:28 INFO - 'sessionrestore_no_auto_restore', 05:30:28 INFO - 'tabpaint']}, 05:30:28 INFO - 'other_nol64': {'tests': ['a11yr', 05:30:28 INFO - 'ts_paint', 05:30:28 INFO - 'tpaint', 05:30:28 INFO - 'sessionrestore', 05:30:28 INFO - 'sessionrestore_no_auto_restore', 05:30:28 INFO - 'tabpaint']}, 05:30:28 INFO - 'svgr': {'tests': ['tsvgx', 05:30:28 INFO - 'tsvgr_opacity', 05:30:28 INFO - 'tart', 05:30:28 INFO - 'tscrollx', 05:30:28 INFO - 'cart']}, 05:30:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:30:28 INFO - 'tests': ['tsvgx', 05:30:28 INFO - 'tsvgr_opacity', 05:30:28 INFO - 'tart', 05:30:28 INFO - 'tscrollx', 05:30:28 INFO - 'cart']}, 05:30:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:28 INFO - 'tests': ['tp5o']}, 05:30:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:28 INFO - 'talos_options': ['--e10s'], 05:30:28 INFO - 'tests': ['tp5o']}, 05:30:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:28 INFO - 'talos_options': ['--xperf_path', 05:30:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:28 INFO - 'tests': ['tp5n']}, 05:30:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:28 INFO - 'talos_options': ['--e10s', 05:30:28 INFO - '--xperf_path', 05:30:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:28 INFO - 'tests': ['tp5n']}}, 05:30:28 INFO - 'talos.zip': {'path': '', 05:30:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:28 INFO - Running post-action listener: _resource_record_post_action 05:30:28 INFO - ##### 05:30:28 INFO - ##### Running create-virtualenv step. 05:30:28 INFO - ##### 05:30:28 INFO - Running pre-action listener: _resource_record_pre_action 05:30:28 INFO - Running main action method: create_virtualenv 05:30:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:30:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:30:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:28 INFO - Using real prefix '/tools/python27' 05:30:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:28 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:31 INFO - Installing pip.................done. 05:30:31 INFO - Return code: 0 05:30:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4db420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd00b4d83a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a36ae00>, '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 0x10a1d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a365b20>, '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.7LgIShoPLf/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.6wY9VoSV0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:30:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7LgIShoPLf/Render', 05:30:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:31 INFO - 'HOME': '/Users/cltbld', 05:30:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:31 INFO - 'LOGNAME': 'cltbld', 05:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:31 INFO - 'MOZ_NO_REMOTE': '1', 05:30:31 INFO - 'NO_EM_RESTART': '1', 05:30:31 INFO - 'PAGER': '/bin/cat', 05:30:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:31 INFO - 'PWD': '/builds/slave/test', 05:30:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:31 INFO - 'SHELL': '/bin/bash', 05:30:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wY9VoSV0G/Listeners', 05:30:31 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 05:30:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:31 INFO - 'USER': 'cltbld', 05:30:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:31 INFO - 'XPC_FLAGS': '0x0', 05:30:31 INFO - 'XPC_SERVICE_NAME': '0', 05:30:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:30:32 INFO - Cleaning up... 05:30:32 INFO - Return code: 0 05:30:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4db420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd00b4d83a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a36ae00>, '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 0x10a1d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a365b20>, '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.7LgIShoPLf/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.6wY9VoSV0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:30:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7LgIShoPLf/Render', 05:30:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:32 INFO - 'HOME': '/Users/cltbld', 05:30:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:32 INFO - 'LOGNAME': 'cltbld', 05:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:32 INFO - 'MOZ_NO_REMOTE': '1', 05:30:32 INFO - 'NO_EM_RESTART': '1', 05:30:32 INFO - 'PAGER': '/bin/cat', 05:30:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:32 INFO - 'PWD': '/builds/slave/test', 05:30:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:32 INFO - 'SHELL': '/bin/bash', 05:30:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wY9VoSV0G/Listeners', 05:30:32 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 05:30:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:32 INFO - 'USER': 'cltbld', 05:30:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:32 INFO - 'XPC_FLAGS': '0x0', 05:30:32 INFO - 'XPC_SERVICE_NAME': '0', 05:30:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:32 INFO - Downloading/unpacking psutil>=0.7.1 05:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:34 INFO - Installing collected packages: psutil 05:30:34 INFO - Running setup.py install for psutil 05:30:34 INFO - building 'psutil._psutil_osx' extension 05:30:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:30:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:30:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:30:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:30:35 INFO - building 'psutil._psutil_posix' extension 05:30:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:30:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:30:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:30:35 INFO - ^ 05:30:35 INFO - 1 warning generated. 05:30:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:30:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:35 INFO - Successfully installed psutil 05:30:35 INFO - Cleaning up... 05:30:36 INFO - Return code: 0 05:30:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a4cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4db420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd00b4d83a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a36ae00>, '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 0x10a1d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a365b20>, '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.7LgIShoPLf/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.6wY9VoSV0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:30:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7LgIShoPLf/Render', 05:30:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:36 INFO - 'HOME': '/Users/cltbld', 05:30:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:36 INFO - 'LOGNAME': 'cltbld', 05:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:36 INFO - 'MOZ_NO_REMOTE': '1', 05:30:36 INFO - 'NO_EM_RESTART': '1', 05:30:36 INFO - 'PAGER': '/bin/cat', 05:30:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:36 INFO - 'PWD': '/builds/slave/test', 05:30:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:36 INFO - 'SHELL': '/bin/bash', 05:30:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wY9VoSV0G/Listeners', 05:30:36 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 05:30:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:36 INFO - 'USER': 'cltbld', 05:30:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:36 INFO - 'XPC_FLAGS': '0x0', 05:30:36 INFO - 'XPC_SERVICE_NAME': '0', 05:30:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:30:38 INFO - Installing collected packages: mozsystemmonitor 05:30:38 INFO - Running setup.py install for mozsystemmonitor 05:30:38 INFO - Successfully installed mozsystemmonitor 05:30:38 INFO - Cleaning up... 05:30:38 INFO - Return code: 0 05:30:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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', '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 0x10a4cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4db420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd00b4d83a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a36ae00>, '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 0x10a1d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a365b20>, '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.7LgIShoPLf/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.6wY9VoSV0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:30: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 blobuploader==1.2.4 05:30:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7LgIShoPLf/Render', 05:30:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:38 INFO - 'HOME': '/Users/cltbld', 05:30:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:38 INFO - 'LOGNAME': 'cltbld', 05:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:38 INFO - 'MOZ_NO_REMOTE': '1', 05:30:38 INFO - 'NO_EM_RESTART': '1', 05:30:38 INFO - 'PAGER': '/bin/cat', 05:30:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:38 INFO - 'PWD': '/builds/slave/test', 05:30:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:38 INFO - 'SHELL': '/bin/bash', 05:30:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wY9VoSV0G/Listeners', 05:30:38 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 05:30:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:38 INFO - 'USER': 'cltbld', 05:30:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:38 INFO - 'XPC_FLAGS': '0x0', 05:30:38 INFO - 'XPC_SERVICE_NAME': '0', 05:30:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30:42 INFO - Downloading docopt-0.6.1.tar.gz 05:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:42 INFO - Running setup.py install for blobuploader 05:30:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:43 INFO - Running setup.py install for requests 05:30:43 INFO - Running setup.py install for docopt 05:30:43 INFO - Successfully installed blobuploader requests docopt 05:30:43 INFO - Cleaning up... 05:30:43 INFO - Return code: 0 05:30:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 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 0x10a4cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4db420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd00b4d83a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a36ae00>, '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 0x10a1d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a365b20>, '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.7LgIShoPLf/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.6wY9VoSV0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7LgIShoPLf/Render', 05:30:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:44 INFO - 'HOME': '/Users/cltbld', 05:30:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:44 INFO - 'LOGNAME': 'cltbld', 05:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:44 INFO - 'MOZ_NO_REMOTE': '1', 05:30:44 INFO - 'NO_EM_RESTART': '1', 05:30:44 INFO - 'PAGER': '/bin/cat', 05:30:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:44 INFO - 'PWD': '/builds/slave/test', 05:30:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:44 INFO - 'SHELL': '/bin/bash', 05:30:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wY9VoSV0G/Listeners', 05:30:44 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 05:30:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:44 INFO - 'USER': 'cltbld', 05:30:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:44 INFO - 'XPC_FLAGS': '0x0', 05:30:44 INFO - 'XPC_SERVICE_NAME': '0', 05:30:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:44 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Xd3rph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:44 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-uUcshl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:44 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-_k5XLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:44 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-JjLdOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:44 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-hm3vRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:44 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-UOAQ0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:45 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-7R7HPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:45 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-lg7e7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:45 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Kuh7tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:45 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-6S_U95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:45 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-vQ0rNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:45 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-hfFyYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:45 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-PAP8WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:45 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-d36iVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:45 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-X_zqfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:45 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-_Ochhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:46 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-6sGHI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:46 INFO - Running setup.py install for manifestparser 05:30:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:46 INFO - Running setup.py install for mozcrash 05:30:46 INFO - Running setup.py install for mozdebug 05:30:46 INFO - Running setup.py install for mozdevice 05:30:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:30:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:46 INFO - Running setup.py install for mozfile 05:30:46 INFO - Running setup.py install for mozhttpd 05:30:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:47 INFO - Running setup.py install for mozinfo 05:30:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:47 INFO - Running setup.py install for mozInstall 05:30:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:47 INFO - Running setup.py install for mozleak 05:30:47 INFO - Running setup.py install for mozlog 05:30:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:47 INFO - Running setup.py install for moznetwork 05:30:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:47 INFO - Running setup.py install for mozprocess 05:30:47 INFO - Running setup.py install for mozprofile 05:30:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:48 INFO - Running setup.py install for mozrunner 05:30:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:48 INFO - Running setup.py install for mozscreenshot 05:30:48 INFO - Running setup.py install for moztest 05:30:48 INFO - Running setup.py install for mozversion 05:30:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:48 INFO - Cleaning up... 05:30:48 INFO - Return code: 0 05:30:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:48 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 0x10a4cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4db420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd00b4d83a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a36ae00>, '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 0x10a1d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a365b20>, '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.7LgIShoPLf/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.6wY9VoSV0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7LgIShoPLf/Render', 05:30:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:48 INFO - 'HOME': '/Users/cltbld', 05:30:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:48 INFO - 'LOGNAME': 'cltbld', 05:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:48 INFO - 'MOZ_NO_REMOTE': '1', 05:30:48 INFO - 'NO_EM_RESTART': '1', 05:30:48 INFO - 'PAGER': '/bin/cat', 05:30:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:48 INFO - 'PWD': '/builds/slave/test', 05:30:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:48 INFO - 'SHELL': '/bin/bash', 05:30:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wY9VoSV0G/Listeners', 05:30:48 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 05:30:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:48 INFO - 'USER': 'cltbld', 05:30:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:48 INFO - 'XPC_FLAGS': '0x0', 05:30:48 INFO - 'XPC_SERVICE_NAME': '0', 05:30:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:49 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-62SwrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:49 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-CcKJk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:49 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-d1cPHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:49 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-aprj2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:49 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-tFmpqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:49 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-1weamO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:49 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-icioFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:49 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-bua8Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:49 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-2iQMfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:49 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-q4pf8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:50 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-WkkHpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:50 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-U_wqTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:50 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-L6XTtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:50 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-HsUx2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:50 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-mdEon5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:50 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-AVmeDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:30:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:50 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-t4DxCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:53 INFO - Downloading blessings-1.6.tar.gz 05:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:53 INFO - Installing collected packages: blessings 05:30:53 INFO - Running setup.py install for blessings 05:30:53 INFO - Successfully installed blessings 05:30:53 INFO - Cleaning up... 05:30:53 INFO - Return code: 0 05:30:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:54 INFO - Reading from file tmpfile_stdout 05:30:54 INFO - Current package versions: 05:30:54 INFO - blessings == 1.6 05:30:54 INFO - blobuploader == 1.2.4 05:30:54 INFO - docopt == 0.6.1 05:30:54 INFO - manifestparser == 1.1 05:30:54 INFO - mozInstall == 1.12 05:30:54 INFO - mozcrash == 0.17 05:30:54 INFO - mozdebug == 0.1 05:30:54 INFO - mozdevice == 0.48 05:30:54 INFO - mozfile == 1.2 05:30:54 INFO - mozhttpd == 0.7 05:30:54 INFO - mozinfo == 0.9 05:30:54 INFO - mozleak == 0.1 05:30:54 INFO - mozlog == 3.1 05:30:54 INFO - moznetwork == 0.27 05:30:54 INFO - mozprocess == 0.22 05:30:54 INFO - mozprofile == 0.28 05:30:54 INFO - mozrunner == 6.11 05:30:54 INFO - mozscreenshot == 0.1 05:30:54 INFO - mozsystemmonitor == 0.0 05:30:54 INFO - moztest == 0.7 05:30:54 INFO - mozversion == 1.4 05:30:54 INFO - psutil == 3.1.1 05:30:54 INFO - requests == 1.2.3 05:30:54 INFO - wsgiref == 0.1.2 05:30:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:54 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 0x10a4cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4db420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd00b4d83a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a36ae00>, '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 0x10a1d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a365b20>, '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.7LgIShoPLf/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.6wY9VoSV0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7LgIShoPLf/Render', 05:30:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:54 INFO - 'HOME': '/Users/cltbld', 05:30:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:54 INFO - 'LOGNAME': 'cltbld', 05:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:54 INFO - 'MOZ_NO_REMOTE': '1', 05:30:54 INFO - 'NO_EM_RESTART': '1', 05:30:54 INFO - 'PAGER': '/bin/cat', 05:30:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:54 INFO - 'PWD': '/builds/slave/test', 05:30:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:54 INFO - 'SHELL': '/bin/bash', 05:30:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wY9VoSV0G/Listeners', 05:30:54 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 05:30:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:54 INFO - 'USER': 'cltbld', 05:30:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:54 INFO - 'XPC_FLAGS': '0x0', 05:30:54 INFO - 'XPC_SERVICE_NAME': '0', 05:30:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:30:54 INFO - Cleaning up... 05:30:54 INFO - Return code: 0 05:30:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:54 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 0x10a4cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4db420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd00b4d83a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a36ae00>, '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 0x10a1d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a365b20>, '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.7LgIShoPLf/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.6wY9VoSV0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:30:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7LgIShoPLf/Render', 05:30:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:54 INFO - 'HOME': '/Users/cltbld', 05:30:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:54 INFO - 'LOGNAME': 'cltbld', 05:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:54 INFO - 'MOZ_NO_REMOTE': '1', 05:30:54 INFO - 'NO_EM_RESTART': '1', 05:30:54 INFO - 'PAGER': '/bin/cat', 05:30:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:54 INFO - 'PWD': '/builds/slave/test', 05:30:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:54 INFO - 'SHELL': '/bin/bash', 05:30:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wY9VoSV0G/Listeners', 05:30:54 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 05:30:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:54 INFO - 'USER': 'cltbld', 05:30:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:54 INFO - 'XPC_FLAGS': '0x0', 05:30:54 INFO - 'XPC_SERVICE_NAME': '0', 05:30:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:54 INFO - Downloading/unpacking jsonschema 05:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:57 INFO - Downloading/unpacking functools32 (from jsonschema) 05:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:57 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:57 INFO - warning: no files found matching '*.txt' 05:30:57 INFO - no previously-included directories found matching 'build' 05:30:57 INFO - no previously-included directories found matching 'dist' 05:30:57 INFO - no previously-included directories found matching '.git*' 05:30:57 INFO - Installing collected packages: jsonschema, functools32 05:30:57 INFO - Running setup.py install for functools32 05:30:57 INFO - warning: no files found matching '*.txt' 05:30:57 INFO - no previously-included directories found matching 'build' 05:30:57 INFO - no previously-included directories found matching 'dist' 05:30:57 INFO - no previously-included directories found matching '.git*' 05:30:57 INFO - Successfully installed jsonschema functools32 05:30:57 INFO - Cleaning up... 05:30:57 INFO - Return code: 0 05:30:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:57 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 0x10a4cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4db420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd00b4d83a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a36ae00>, '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 0x10a1d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a365b20>, '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.7LgIShoPLf/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.6wY9VoSV0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:30:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7LgIShoPLf/Render', 05:30:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:30:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:30:57 INFO - 'HOME': '/Users/cltbld', 05:30:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:30:57 INFO - 'LOGNAME': 'cltbld', 05:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:57 INFO - 'MOZ_NO_REMOTE': '1', 05:30:57 INFO - 'NO_EM_RESTART': '1', 05:30:57 INFO - 'PAGER': '/bin/cat', 05:30:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:57 INFO - 'PWD': '/builds/slave/test', 05:30:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:30:57 INFO - 'SHELL': '/bin/bash', 05:30:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wY9VoSV0G/Listeners', 05:30:57 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 05:30:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:30:57 INFO - 'USER': 'cltbld', 05:30:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:30:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:57 INFO - 'XPC_FLAGS': '0x0', 05:30:57 INFO - 'XPC_SERVICE_NAME': '0', 05:30:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:58 INFO - Downloading/unpacking flake8 05:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:31:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:31:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:01 INFO - no previously-included directories found matching 'docs/_build' 05:31:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:31:01 INFO - Running setup.py install for pep8 05:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:01 INFO - no previously-included directories found matching 'docs/_build' 05:31:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:31:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:31:01 INFO - Cleaning up... 05:31:02 INFO - Return code: 0 05:31:02 INFO - Running post-action listener: _resource_record_post_action 05:31:02 INFO - Running post-action listener: _start_resource_monitoring 05:31:02 INFO - Starting resource monitoring. 05:31:02 INFO - ##### 05:31:02 INFO - ##### Running install step. 05:31:02 INFO - ##### 05:31:02 INFO - Running pre-action listener: _resource_record_pre_action 05:31:02 INFO - Running main action method: install 05:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:02 INFO - Reading from file tmpfile_stdout 05:31:02 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:31:02 INFO - Reading from file tmpfile_stdout 05:31:02 INFO - Output received: 05:31:02 INFO - Usage: mozinstall [options] installer 05:31:02 INFO - Options: 05:31:02 INFO - -h, --help show this help message and exit 05:31:02 INFO - -d DEST, --destination=DEST 05:31:02 INFO - Directory to install application into. [default: 05:31:02 INFO - "/builds/slave/test"] 05:31:02 INFO - --app=APP Application being installed. [default: firefox] 05:31:02 INFO - mkdir: /builds/slave/test/build/application 05:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:31:36 INFO - Reading from file tmpfile_stdout 05:31:36 INFO - Output received: 05:31:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:31:36 INFO - Running post-action listener: _resource_record_post_action 05:31:36 INFO - ##### 05:31:36 INFO - ##### Running run-tests step. 05:31:36 INFO - ##### 05:31:36 INFO - Running pre-action listener: _resource_record_pre_action 05:31:36 INFO - Running main action method: run_tests 05:31:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:31:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:31:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:31:36 INFO - 2016-04-04 05:31:36.385 screenresolution[1636:7576] starting screenresolution argv=screenresolution get 05:31:36 INFO - 2016-04-04 05:31:36.388 screenresolution[1636:7576] Display 0: 1600x1200x32@60 05:31:36 INFO - 2016-04-04 05:31:36.394 screenresolution[1637:7578] starting screenresolution argv=screenresolution list 05:31:36 INFO - Available Modes on Display 0 05:31:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:31:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:31:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:31:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:31:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:31:36 INFO - Intel Iris: 05:31:36 INFO - Chipset Model: Intel Iris 05:31:36 INFO - Type: GPU 05:31:36 INFO - Bus: Built-In 05:31:36 INFO - VRAM (Dynamic, Max): 1536 MB 05:31:36 INFO - Vendor: Intel (0x8086) 05:31:36 INFO - Device ID: 0x0a2e 05:31:36 INFO - Revision ID: 0x0009 05:31:36 INFO - Displays: 05:31:36 INFO - Display: 05:31:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:31:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:31:36 INFO - Display Serial Number: 1600x1200 60 05:31:36 INFO - Main Display: Yes 05:31:36 INFO - Mirror: Off 05:31:36 INFO - Online: Yes 05:31:36 INFO - Rotation: Supported 05:31:36 INFO - Return code: 0 05:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:31:36 INFO - Python 2.7.3 05:31:36 INFO - Return code: 0 05:31:36 INFO - grabbing minidump binary from tooltool 05:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a36ae00>, '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 0x10a1d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a365b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:31:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:31:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:31:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:36 INFO - Return code: 0 05:31:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:31:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:31:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:31:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:31:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:31:37 INFO - Return code: 0 05:31:37 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/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:31:37 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/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0075 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7LgIShoPLf/Render', 05:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:37 INFO - 'HOME': '/Users/cltbld', 05:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:37 INFO - 'LOGNAME': 'cltbld', 05:31:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:31:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:37 INFO - 'MOZ_NO_REMOTE': '1', 05:31:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:31:37 INFO - 'NO_EM_RESTART': '1', 05:31:37 INFO - 'PAGER': '/bin/cat', 05:31:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:37 INFO - 'PWD': '/builds/slave/test', 05:31:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:37 INFO - 'SHELL': '/bin/bash', 05:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wY9VoSV0G/Listeners', 05:31:37 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 05:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:37 INFO - 'USER': 'cltbld', 05:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:37 INFO - 'XPC_FLAGS': '0x0', 05:31:37 INFO - 'XPC_SERVICE_NAME': '0', 05:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:37 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/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:31:38 INFO - mozversion application_buildid: 20160404032320 05:31:38 INFO - mozversion application_changeset: 6fc436f9db859d961581a5f27bbb69731679f593 05:31:38 INFO - mozversion application_display_name: Nightly 05:31:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:38 INFO - mozversion application_name: Firefox 05:31:38 INFO - mozversion application_remotingname: firefox 05:31:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:31:38 INFO - mozversion application_vendor: Mozilla 05:31:38 INFO - mozversion application_version: 48.0a1 05:31:38 INFO - mozversion platform_buildid: 20160404032320 05:31:38 INFO - mozversion platform_changeset: 6fc436f9db859d961581a5f27bbb69731679f593 05:31:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:31:38 INFO - mozversion platform_version: 48.0a1 05:31:38 INFO - using testdate: 1459773098 05:31:38 INFO - actual date: 1459773098 05:31:38 INFO - starting webserver on 'localhost:49272' 05:31:38 INFO - SUITE-START | Running 2 tests 05:31:38 INFO - TEST-START | dromaeo_css 05:31:38 INFO - operating with platform_type : mac_ 05:31:38 INFO - Initialising browser for dromaeo_css test... 05:31:38 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpRyT_b9/profile http://localhost:49272/getInfo.html) 05:31:40 INFO - PROCESS | 1655 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:31:41 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 05:31:41 INFO - PROCESS | 1655 | colorDepth:24 05:31:41 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 05:31:41 INFO - PROCESS | 1655 | __metrics 05:31:41 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 05:31:41 INFO - TEST-INFO | 1655: exit 0 05:31:41 INFO - Browser initialized. 05:31:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:41 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpRyT_b9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:53 INFO - PROCESS | 1658 | RSS: Main: 246591488 05:31:53 INFO - PROCESS | 1658 | 05:32:43 INFO - PROCESS | 1658 | 1459773163620 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] 05:34:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 05:34:55 INFO - PROCESS | 1658 | RSS: Main: 259227648 05:34:55 INFO - PROCESS | 1658 | 05:37:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 05:37:58 INFO - PROCESS | 1658 | RSS: Main: 270929920 05:37:58 INFO - PROCESS | 1658 | 05:40:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 05:41:00 INFO - PROCESS | 1658 | RSS: Main: 273534976 05:41:00 INFO - PROCESS | 1658 | 05:44:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 05:44:02 INFO - PROCESS | 1658 | RSS: Main: 274604032 05:44:02 INFO - PROCESS | 1658 | 05:47:05 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 05:47:05 INFO - PROCESS | 1658 | RSS: Main: 277446656 05:47:05 INFO - PROCESS | 1658 | 05:50:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 05:50:08 INFO - PROCESS | 1658 | RSS: Main: 278401024 05:50:08 INFO - PROCESS | 1658 | 05:50:08 INFO - PROCESS | 1658 | __start_tp_report 05:50:08 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 05:50:08 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 05:50:08 INFO - PROCESS | 1658 | |i|pagename|runs| 05:50:08 INFO - PROCESS | 1658 | |0;dojo.html;2818.3517790908104;3245.561849150364;3561.9465708014386;3576.606573276939;3626.329129111113;5855.23881895354;5878.353381128078;5891.88216235675;5905.173275741389;5981.072933695274;5808.767649294034;5939.0794426863795;5953.553483488734;6024.9096263555975;6044.607100538473;5250.7637156328055;5327.360716713981;5354.518093371596;5361.705106219157;5376.731163441832;193.0508892241301;5292.391374991887;5312.574994000471;5366.275552800361;5411.512963833255;4464.620507256887;5302.734863256841;5302.814401495948;5320.441353657888;5330.413654498002;5238.978399212155;5346.251524786533;5352.464753524655;5355.357357117132;5384.434634363374;5224.686518808883;5225.477452254782;5292.655977361498;5304.336957880265;5362.758675859557;5188.325517682715;5242.842714718565;5768.855778605526;5849.33294011209;5876.823695289148;6134.834601026134;6239.157713708637;6283.497320214372;6298.212723409574;6301.338359472235;6251.437370636619;6328.240611126648;6328.683565821737;6329.272133704637;6346.365363463663;5994.760209591611;5997.880042399128;6017.578769486137;6020.939790602081;6025.9397406026255;6226.315105338409;6353.714082866282;6390.265119511223;6423.0686550450855;6444.516661250425;6242.968785156045;6285.497160227171;6308.728857611256;6320.146780184708;6333.809985700436;6253.843653908689;6275.309715931244;6307.873842523124;6310.5898116622275;6327.651979141099;6168.228971378578;6224.221972253468;6280.214973128359;6283.151774510474;6288.779892703734;5182.170852663556;6069.423404776539;6268.404501572434;6280.780172693934;6284.654344011124;4954.529319714621;5005.649604527648;5011.123053465702;5015.623828212899;5032.446430892599;4451.154280686659;4455.643548516111;4514.074614703978;4544.2047641662575;4563.338315944236;5944.64332140073;5969.522438204933;5989.431004054608;6010.459058684739;6012.158297838306;6290.559660823698;6295.874082518416;6306.905396419057;6313.494920406357;6323.620582765049;4924.975375123101;5865.912011319833;5955.3151387590115;6031.125486804389;6047.909281360783;5477.945220547744;5481.945180548143;5489.890202195934;5495.835124946258;5510.5316048135555;5868.325142608569;6230.813075607739;6344.429001389897;6514.413702766774;6527.804165875032;6197.977333739883;6264.718087685974;6273.121762953099;6304.71628776697;6311.053341998737;6301.306856245901;6472;6473.190851143607;6523.902141467787;6525.771597994048;6137.96931015342;6236.095766113979;6257.7184026719815;6274.027525733519;6326.43062124411;6229.2524897012645;6264.624122552661;6277.497800175884;6283.434490895658;6300.1809764732125;5599.664020158803;6210.975189093749;6243.500519958302;6259;6273.905891411541;6122.877542449037;6132.540059495466;6194.256689197326;6243.469305109116;6275.466585340298;5651.660900345993;5808.664007278265;6114.206128133811;6133.049377346519;6186.10301506288;5020.3724534433195;6165.907511387422;6229.4393504582995;6270.874582508233;6279.215098112736;6065.4541091302;6081.817545473643;6112.847178820387;6146.661933593696;6178.289496707756 05:50:08 INFO - PROCESS | 1658 | |1;ext.html;424.92351376752174;583.6882789083451;603.81953281335;604.6553464525217;625.7497001199521;37579;38224.617753822524;38270.42594361083;38275.80862095692;38526.61473385265;41267.9683007925;41298;41613;42173;42191.578084219145;9515.809683806337;9705.805883882318;9715.271354648394;9722.854157187649;9723.367981081243;9520.42877427353;9559.904400956006;9572.664956726516;9640.662576809813;9700.854487182698;9659.758506037335;9678.951605241964;9696.709098727015;9716.902830971705;9745.951270243639;9549.379290346105;9593.47235902025;9648.951755241249;9688.934217236098;9701.757456063584;9493.240540756791;9559.856602150974;9621.615135394575;9641.614335426575;9671.468069256189;32769.836150819334;39535.40696889549;39945;39956.200875982315;39999.80000599987;3087.5677405163296;3147.291859331632;3298.8515516801804;3300.339932013607;3313.1054615253747;27315.590266146024;27615.44769104627;27794;28340.43319133606;28374.574381384296;2726.5910113482937;2781.9304517387027;2785.7632101271415;2898.695636958131;2960.067578712699;342079;345236;346311;348878;349707.2514637436;46538.5346146541;68054.65972670105;68498;68526.91628876713;69120;45892.311615325794;46016.30975535369;46044.769776151574;46049.30926036112;46460;15751.369945202063;15765.132917689407;15839.970401923838;15928.884978051658;16004.839951600568;10551.84172237417;12513.937430312972;12663.050271229695;12689.873101269053;12720.363981800872;14918.92540537312;15028.549143525712;15058.924705376403;15182.924085379502;15209.163496007826;6398.552101352953;6512.153420055457;6535.150430444012;6539.607623542603;6555.704993275314;823.4153750836973;948.2035090523993;959.6976952260015;1030.7886883188928;1031.6698656429871;28736.850525978727;28850;29605.932098306264;29648.2587935299;30116.247093822392;1066.2376400873413;1079.4440862955585;1088.2599832114238;1099.934003959749;1174.1956759619688;15070.849291507164;15108.320125594375;15121.017133886262;15586.454474093352;15637.452689155825;539769;720078;738430;741350;746097;61661.38338616646;61907.690461547405;62613.68693156505;62762.686186568775;62859;1480.9111453312835;1493.8580834820675;1494.036346556465;1502.1738044075714;1509.7433436315853;30373.39253214879;30672.386552269276;30767.076987690405;31032.22419439532;32357.029289121365;54607.453925460235;54766.904661907334;54957.72521137369;54985.450145498035;55006.44993550173;499544;500221.4988925032;502065;506051;507611;34908.82545587256;46895;47477.52522474731;47754;48515;47941;48185.03629927312;48264.517354826;50056.499435005186;50162.247566285805;34130.146746330545;41672.3749143757;41887.09413125812;42021.73934781962;43768.343474847265;40840.38739418852;41330.586694132675;41399.58600413957;41607.37588936108;42262.788686056374;40343.596564033985;40950.795246023576;41126;41645.58354416417;42052;39266.80366598263;40283.3957490632;40872.97817554466;41213.79393103015;41772;25549.3612659685;26131.73868261293;26241.73758262393;26344.967051358257;26476.338091547095 05:50:08 INFO - PROCESS | 1658 | |2;jquery.html;331.49281599153295;359.2043623374227;364.4605983144945;368.24142266930124;372.52689084862243;19342.41972740818;19493.610127797434;20046.29837955672;20113.19547218113;20171.19315227391;18466;18833;20086.69869951952;20420.489487762814;20617.1753129875;4883.487233840449;5273.920891186635;5829.708514574276;5884.764609415618;5986.3415024347505;4209.936850947238;5792.565557583177;6201;6464.676766161697;6482.448991835699;6395.840103997414;6417.101605775195;6428.517861160408;6430.906745853216;6433.163688720483;5007.949920500785;5750.25246717924;5754.194412782193;5774.249347584787;5791.942080579182;5268.631195816294;5470.261514695505;5474.288342515487;5527.585431092684;5532.7786888524415;13024.86975130246;13295.135816171918;13356.131851429724;13472.393742281523;13483.258420786853;1725.585859393749;2001.549651328454;2109.003438484079;2134.4557137929883;2175.086463685256;7973.362131029504;9363.906360936371;10183.949080254626;11129.72175695606;14745.959754716276;1675.4973507947566;1699.9205504504605;1737.4527023987403;1755.1926113987581;1776.1030679506896;72370.27629723688;74442.62778686071;74719.62640186764;84180.99999999939;94902;10676.252662313718;11048;11143.2199746017;11164.274322169033;11271.943640281746;13561.186328820302;13650.863491364958;13681.452741890413;13686.247256400993;13721.862781372258;8342.37432192588;8514.48913065218;8526.701565445179;8538.53038082899;8553.401261911606;7964.646010178168;8663.956680216685;8682.6092825823;8689.522076285739;8755.592212141712;3574.7855128692363;4129.2773764591075;4391.692581519327;4396.164728701537;4413.183561041154;1722.6382459683607;1803.4138904855974;1816.273490603769;1898.572821115238;1905.514093906045;890.8841850559386;954.1222075690381;955.9761005974767;967.0281367226033;981.4160574458186;18993.33523326677;19759;19765.110570024382;19900.104495297746;20013.499662508555;857.4598003257908;939.6664184214642;947.275334369208;1000.1248907206194;1009.4902074452355;8511.702090426805;10741.570337186426;10997.835032474519;11011.83482247767;11054.944725276322;604190;609593;613809.9309503424;623160;623321;98787;120041;120119;120613.79386206201;120629.19056214164;451.4965813118415;468.23911144390365;468.9413823272091;469.5586149019979;471.49785478465327;9110.863337050083;10351.327163734333;11177.441127943408;17537.473875783748;18305.359312424;42799.35800962926;49003;49223;53552.19671705006;53607.731961339945;67556.66221668861;68169.65915170392;68799;68903;69349.65325173341;7762.262585054411;7917.604119793872;8001.759947201594;8048.114707382067;8279.917200827915;12187.939060304641;12239.938800305941;12435;12647;12780.808287875503;10243.334183278062;10699.89300106989;10874.565017399533;10898.618548350769;10929.672109836718;10577.735556611146;10738.46307684597;10747.623833165802;10816.459177040959;11096.722581935193;11070.667879963614;11085.168612353944;11163.49764260594;11193.384363859741;11436.485358158736;6117.663528505975;7889.763307100796;8010.519368837889;8106.432549721699;8155.469894456842;7019.298070193144;9695.66065187715;11039.172062095535;11061.778764424505;11158.665240042812 05:50:08 INFO - PROCESS | 1658 | |3;mootools.html;1596.3215633355824;1603.4548253593775;1882.962340753185;1962.8822270663752;1980.7226988221641;7925.128235894047;8433.819265302862;8720.8691869622;8969.865452018224;8976.057513961037;7261.963690181555;8660.523671198082;8731.432456890314;8779.824403511926;8792.604332805024;2477.4178068154015;2505.8747062646885;2506.686664166979;2515.05685367987;2515.346010037385;1955.9413217603494;2068.079704531484;2442.682451281331;2509.335026218054;2512.6984761828517;2127.7872212778675;2453.092355828346;2464.3346296499935;2469.777720005199;2525.7600527949908;2484.254723582918;2496.5131799299143;2512.836665616738;2518.6851643544555;2537.0486067724605;2495.6131799571094;2496.6879140107485;2498.362917456037;2504.2362079565723;2505.3736565858535;8921.910780892173;8936.865947010736;8952.776180595472;8973.147550982647;8980.8652870207;5275.472452754732;5363.088274993261;5389.730513474311;5399.217113518557;5412.943081628995;3585.229175727205;3670.7981061041633;3718.6653201211752;3732.328180927432;3739.8878033659034;1045.3362115056918;1061.0027069425428;1064.1912146768434;1070.4433694478905;1079.6922876980102;11274.154438417152;11844.230125041844;11951.760964780655;11996.70008249792;11997.280163190237;4834;4840.467548569654;4850.6362022848425;4979.3277907482025;5023.874403139877;10079.042490963348;10100.393976361294;10111.494425278706;10119.898801011896;10152;5554.389017208104;5563.026470367669;5577.274954256002;5578.386377498472;5579;4484.529124441952;4895.804167833318;4991.97664478781;4993.775280112403;5057.367829021372;3842.769433833979;3955.624215699504;3964.801759911993;3982.183652351319;4002.959970400317;1030.1192480429274;1340.604521666111;1351.3243378310844;1361.8297712785902;1373.5810577773875;1187.3647598534915;1325.516186591887;1356.945722171102;1386.7157232767258;1387.0221493846814;8178.550179740171;8365.539895305817;8373.162683731578;8395.328373730086;8395.95802020986;1180.6458062581362;1199.5082016373244;1218.4821450883517;1222.6332100369852;1227.1777908801125;5284.947150528523;6328.082428047907;6376.107344971708;6470.64411457365;6481.125048118538;10347.534360953776;10668.466576671135;10718;10751.51618177184;10839.891601084046;10522.947385263025;10737.624183153552;10762.408067556204;10846.240763146505;10861.83707244392;8372.162783721578;8458.534780587004;8529.445586037013;8547.74356769298;8589.742307730654;7927.246911543394;7969.8406031880195;7985.121636619851;7997.520148791091;8093.635786389509;9481.051894810464;9689;9715.417074975525;9773.755656108655;9829.655962041294;9876.703698889045;10034.147097496794;10195.949020254851;10355.17158627323;10396.272260941661;7005.859882802417;7118.359347658528;7206.89189662166;7472.103347598323;7519.360854327443;8202.589870506332;8223.259906608433;8290.544020078954;8302.792430189294;8415.831683366421;7276.818079548054;7333.376662983706;7377.077865266841;7557.395408367208;7563.546187228784;7108.715651374094;7132.643367831484;7195.316444937723;7200.603966781878;7205.207427182901;7532.171461139161;7629.504082234637;7631.236876312324;7642.235776422313;7675.424343174396;6848.383645471931;6880.9655951721925;6895.6552172392185;6975.3024697529845;6988.336108069725;7104.680289387094;7122.928770712227;7141.321574450419;7160.391366733886;7171.964140179266 05:50:08 INFO - PROCESS | 1658 | |4;prototype.html;326.9150020994542;327.3698131097637;330.6214384529712;332.622473492586;335.7398016537184;6008.849778755533;6434.0670602762575;6840.144981877265;6910.827229319276;6945.305469453052;6773.221079575838;6801.115854938864;6826.726930922757;6834.487413443987;6888.138982627159;4774.7612619369065;4902.264660300948;5003.424606170301;5021.397432308128;5097.031564002837;4368.907773056736;4442.600165985061;5046.243063540462;5051;5060.671056381342;4292.97853510732;5021.748912554376;5049.798008079672;5062.367204099488;5077.873053173664;4403.207422663919;4701.647376446763;5037.244413337992;5042.168042273021;5062;3535.840887160058;4284.207421627009;4296.162248361571;4299.290617048183;4302.311630139194;6405.135306733578;6652.368025037662;6695.866082678368;6707.7652282170375;6708.19501659804;5860.970695146497;5934.258217722785;5944.762209511614;5978;6020.127081573148;7336.376408005326;7366.152892417387;7366.742164024287;7373.926260737378;7398.593077380742;4603.953960460386;4839.951600483985;4853.0779151961015;4855.63582731293;4863.2461968394955;6694.531382803206;7834.1382447931255;7840.764777056697;7849.882251766228;7867.645955932054;4739.526047395302;4920.72935988524;4925.162722337212;4931.988942266827;4946.5053494650965;4989.925151122736;5020.472850350734;5037.672551284155;5041.521055499722;5046.470120637354;5914.112883067488;5970.313413957364;5975.55183361241;5981.551383646244;5986.371430999682;7401.259874012663;7411.036565246483;7423.591702456309;7431.777046688608;7436;1727.991360043217;1756.1307152959366;1758.164871685939;1761.744547040672;1763.9206235719423;1083.106437189322;1134.2287244673537;1136.8976792088752;1138.1009002887793;1139.7777433400572;5307.62846600742;5866.2373891393845;6878.69045892936;6905.516613836983;6972.51192416526;7391.930259527341;7625.084989801259;7637.770866874002;7656.961715191388;7688.961555192188;6650.70071846768;6752.223494298219;6885.242623311432;6893.4140598048725;6893.724251029903;4053.5541090480024;4087.2438598859308;4094.3653733671326;4111.177764447122;4114.259433301974;6870.416014638712;8088.474249173785;8106.797330066677;8106.959465202636;8137.430379873352;7753.806154846174;7922.247386498273;7992.760217193493;8011;8032.598370081472;8038.155993620586;8072.878906816285;8092.71675491355;8113.310368618615;8138.715144969898;7712.074551053685;7712.807179820549;7722.7297044603165;7727.536347819148;7747.612619369122;7579.317861392501;7598.466712978491;7609.315161635479;7648.579328137006;7652.80867978305;7838.764837054898;8032.759017229492;8097.959510202411;8113.6754529818145;8160.591970401338;4740.5733483986605;4745.644076694331;4774.880627984328;4776.928346074881;4803.927941080957;7665.540067595962;7701.807454813675;7711.344535714527;7712.383009359126;7715.537067775951;5995.550333724901;7410.888836667562;7428.665710042953;7434.702611895464;7480.102387713509;7031.964840175767;7418.66616002292;7423.591702456417;7433.256674332523;7454.403647708279;7218.097737782778;7260.419166466564;7275.672594733144;7279;7286.635668216462;7403.51877127985;7410.370118539984;7414.406847452083;7436.851262974818;7439.776806695808;6302.71637776292;6903.6203008835;6919.342662447059;7231.891521627285;7241.13106427211 05:50:08 INFO - PROCESS | 1658 | |5;yui.html;665.9167604049495;668.0647094068304;696.2028477393385;756.8259300360917;758.772368289513;14395;14665.193414362206;14727.263636818156;14743.820494360452;14760.557183284493;15226.162561059138;15657.138857362841;15700.842991570082;15707.921460392681;15712.214389280547;749.3405802893446;931.7514530529123;932.3986029011301;946.7727745341103;947.8815148106487;897.640943622553;898.3890954151175;936.5738588942049;936.625349860058;939.2486011191054;993.4734590666922;994.6717583197527;998.2912132386015;999.7500624843789;1000.174855744014;950.2065775077818;978.5156347607945;982.3418309732497;985.9014098590084;987.9851802223009;707.3033062433499;730.2478447199393;731.4550659758514;733.4205977277944;734.3244215321863;13433.596992090155;15180.316885740169;15202.695946081127;15234.695306093927;15384.615384615363;12367;12392.938035309766;12424.937875310565;12598.244105353708;12646.367681615882;9921.50392480373;9992.500374981222;10423.374597524173;10479.056884880398;10684;3414.2488652496413;3444.9827750861336;3528.259065596228;3529.541159649229;3535.9116022099397;74326;75451;77089.61455192744;79806;80316;9255.259579233645;9366.718998430058;9389.342746007715;9397.718068457958;9448.149666530046;20588.691169632468;20767;20846.374608761762;20978.895105524374;21282.574348512942;7241.42068634508;7348.678006356699;7433.85132297351;7436.516626419266;7679.846403071907;3998.1803730235233;4004.799760011988;4080.6939479539155;4085.22380747657;4088.632023117934;3587.5336206293014;3624.5831729350934;3631.763935344194;3641.5266015417824;3646.7082633389264;643.5077165968038;655.1548502431905;658.4074333100248;665.8867992441296;669.1434963247052;415.4453804171405;522.2062465053098;545.427301333606;586.4985437451003;587.1310460518457;8152.551609661407;8277.172282771675;8308.12764659714;8409.579521023925;8427.157284271647;432.4464685202945;584.7602482981957;605.1751888077256;626.0484064222356;628.446966669328;3152;3821.885343439701;3847.634474724897;3878.3600705883214;3918.2555314490155;85782;93123.0687693128;96626;96674;96742;75625.32810039159;76288;77058;78118.82821757678;78290.6085469569;62021.759564809356;65400.67299663471;70090.64954675194;70468.23829404305;70725;7940.205979402013;8197.180281971756;8228.25945664893;8413.07456179832;8552.657893684183;43915.90210244642;44091.338629919934;44287;44717;45891;47815.28277075777;51398.20106296262;51447.713807153625;57241;62773;10430.426326552113;10511.842322365324;10842.620508282173;11004.504797284302;11045.950634689692;9763.267754918268;11754.11844111678;11805.586804461802;11910.880891190976;12019.819702704292;11085.390433238199;11103;11203.21577489568;11222.989930906258;11299.717507062389;11161.441927903736;11184.832227516432;11278.436078195893;11293.604723834625;11764.470598822902;10953.83569246478;11158.330500170016;11372.20394572372;11403.543858245577;11604.535818567163;9471.905280947103;9537.14165725088;9554.808903821746;9626;9782.706518804447;9012.2790176787;9502.097300756417;9590.08894155082;9593.712188634352;9763.072508111718 05:50:08 INFO - PROCESS | 1658 | __end_tp_report 05:50:08 INFO - PROCESS | 1658 | __start_cc_report 05:50:08 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,375 05:50:08 INFO - PROCESS | 1658 | __end_cc_report 05:50:08 INFO - PROCESS | 1658 | __startTimestamp1459774208272__endTimestamp 05:50:08 INFO - PROCESS | 1658 | 05:50:08 INFO - PROCESS | 1658 | ------- Summary: start ------- 05:50:08 INFO - PROCESS | 1658 | Number of tests: 6 05:50:08 INFO - PROCESS | 1658 | 05:50:08 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5788.68 Median:6069.42 stddev:795.11 (13.1%) stddev-sans-first:762.64 05:50:08 INFO - PROCESS | 1658 | Values: 2818.4 3245.6 3561.9 3576.6 3626.3 5855.2 5878.4 5891.9 5905.2 5981.1 5808.8 5939.1 5953.6 6024.9 6044.6 5250.8 5327.4 5354.5 5361.7 5376.7 193.1 5292.4 5312.6 5366.3 5411.5 4464.6 5302.7 5302.8 5320.4 5330.4 5239.0 5346.3 5352.5 5355.4 5384.4 5224.7 5225.5 5292.7 5304.3 5362.8 5188.3 5242.8 5768.9 5849.3 5876.8 6134.8 6239.2 6283.5 6298.2 6301.3 6251.4 6328.2 6328.7 6329.3 6346.4 5994.8 5997.9 6017.6 6020.9 6025.9 6226.3 6353.7 6390.3 6423.1 6444.5 6243.0 6285.5 6308.7 6320.1 6333.8 6253.8 6275.3 6307.9 6310.6 6327.7 6168.2 6224.2 6280.2 6283.2 6288.8 5182.2 6069.4 6268.4 6280.8 6284.7 4954.5 5005.6 5011.1 5015.6 5032.4 4451.2 4455.6 4514.1 4544.2 4563.3 5944.6 5969.5 5989.4 6010.5 6012.2 6290.6 6295.9 6306.9 6313.5 6323.6 4925.0 5865.9 5955.3 6031.1 6047.9 5477.9 5481.9 5489.9 5495.8 5510.5 5868.3 6230.8 6344.4 6514.4 6527.8 6198.0 6264.7 6273.1 6304.7 6311.1 6301.3 6472.0 6473.2 6523.9 6525.8 6138.0 6236.1 6257.7 6274.0 6326.4 6229.3 6264.6 6277.5 6283.4 6300.2 5599.7 6211.0 6243.5 6259.0 6273.9 6122.9 6132.5 6194.3 6243.5 6275.5 5651.7 5808.7 6114.2 6133.0 6186.1 5020.4 6165.9 6229.4 6270.9 6279.2 6065.5 6081.8 6112.8 6146.7 6178.3 05:50:08 INFO - PROCESS | 1658 | 05:50:08 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:66345.55 Median:41503.48 stddev:143844.77 (346.6%) stddev-sans-first:144163.14 05:50:08 INFO - PROCESS | 1658 | Values: 424.9 583.7 603.8 604.7 625.7 37579.0 38224.6 38270.4 38275.8 38526.6 41268.0 41298.0 41613.0 42173.0 42191.6 9515.8 9705.8 9715.3 9722.9 9723.4 9520.4 9559.9 9572.7 9640.7 9700.9 9659.8 9679.0 9696.7 9716.9 9746.0 9549.4 9593.5 9649.0 9688.9 9701.8 9493.2 9559.9 9621.6 9641.6 9671.5 32769.8 39535.4 39945.0 39956.2 39999.8 3087.6 3147.3 3298.9 3300.3 3313.1 27315.6 27615.4 27794.0 28340.4 28374.6 2726.6 2781.9 2785.8 2898.7 2960.1 342079.0 345236.0 346311.0 348878.0 349707.3 46538.5 68054.7 68498.0 68526.9 69120.0 45892.3 46016.3 46044.8 46049.3 46460.0 15751.4 15765.1 15840.0 15928.9 16004.8 10551.8 12513.9 12663.1 12689.9 12720.4 14918.9 15028.5 15058.9 15182.9 15209.2 6398.6 6512.2 6535.2 6539.6 6555.7 823.4 948.2 959.7 1030.8 1031.7 28736.9 28850.0 29605.9 29648.3 30116.2 1066.2 1079.4 1088.3 1099.9 1174.2 15070.8 15108.3 15121.0 15586.5 15637.5 539769.0 720078.0 738430.0 741350.0 746097.0 61661.4 61907.7 62613.7 62762.7 62859.0 1480.9 1493.9 1494.0 1502.2 1509.7 30373.4 30672.4 30767.1 31032.2 32357.0 54607.5 54766.9 54957.7 54985.5 55006.4 499544.0 500221.5 502065.0 506051.0 507611.0 34908.8 46895.0 47477.5 47754.0 48515.0 47941.0 48185.0 48264.5 50056.5 50162.2 34130.1 41672.4 41887.1 42021.7 43768.3 40840.4 41330.6 41399.6 41607.4 42262.8 40343.6 40950.8 41126.0 41645.6 42052.0 39266.8 40283.4 40873.0 41213.8 41772.0 25549.4 26131.7 26241.7 26345.0 26476.3 05:50:08 INFO - PROCESS | 1658 | 05:50:08 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:33058.86 Median:2250.90 stddev:101535.60 (4510.9%) stddev-sans-first:101790.69 05:50:08 INFO - PROCESS | 1658 | Values: 331.5 359.2 364.5 368.2 372.5 19342.4 19493.6 20046.3 20113.2 20171.2 18466.0 18833.0 20086.7 20420.5 20617.2 4883.5 5273.9 5829.7 5884.8 5986.3 4209.9 5792.6 6201.0 6464.7 6482.4 6395.8 6417.1 6428.5 6430.9 6433.2 5007.9 5750.3 5754.2 5774.2 5791.9 5268.6 5470.3 5474.3 5527.6 5532.8 13024.9 13295.1 13356.1 13472.4 13483.3 1725.6 2001.5 2109.0 2134.5 2175.1 7973.4 9363.9 10183.9 11129.7 14746.0 1675.5 1699.9 1737.5 1755.2 1776.1 72370.3 74442.6 74719.6 84181.0 94902.0 10676.3 11048.0 11143.2 11164.3 11271.9 13561.2 13650.9 13681.5 13686.2 13721.9 8342.4 8514.5 8526.7 8538.5 8553.4 7964.6 8664.0 8682.6 8689.5 8755.6 3574.8 4129.3 4391.7 4396.2 4413.2 1722.6 1803.4 1816.3 1898.6 1905.5 890.9 954.1 956.0 967.0 981.4 18993.3 19759.0 19765.1 19900.1 20013.5 857.5 939.7 947.3 1000.1 1009.5 8511.7 10741.6 10997.8 11011.8 11054.9 604190.0 609593.0 613809.9 623160.0 623321.0 98787.0 120041.0 120119.0 120613.8 120629.2 451.5 468.2 468.9 469.6 471.5 9110.9 10351.3 11177.4 17537.5 18305.4 42799.4 49003.0 49223.0 53552.2 53607.7 67556.7 68169.7 68799.0 68903.0 69349.7 7762.3 7917.6 8001.8 8048.1 8279.9 12187.9 12239.9 12435.0 12647.0 12780.8 10243.3 10699.9 10874.6 10898.6 10929.7 10577.7 10738.5 10747.6 10816.5 11096.7 11070.7 11085.2 11163.5 11193.4 11436.5 6117.7 7889.8 8010.5 8106.4 8155.5 7019.3 9695.7 11039.2 11061.8 11158.7 05:50:08 INFO - PROCESS | 1658 | 05:50:08 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:6092.85 Median:4992.88 stddev:3188.06 (63.9%) stddev-sans-first:3179.09 05:50:08 INFO - PROCESS | 1658 | Values: 1596.3 1603.5 1883.0 1962.9 1980.7 7925.1 8433.8 8720.9 8969.9 8976.1 7262.0 8660.5 8731.4 8779.8 8792.6 2477.4 2505.9 2506.7 2515.1 2515.3 1955.9 2068.1 2442.7 2509.3 2512.7 2127.8 2453.1 2464.3 2469.8 2525.8 2484.3 2496.5 2512.8 2518.7 2537.0 2495.6 2496.7 2498.4 2504.2 2505.4 8921.9 8936.9 8952.8 8973.1 8980.9 5275.5 5363.1 5389.7 5399.2 5412.9 3585.2 3670.8 3718.7 3732.3 3739.9 1045.3 1061.0 1064.2 1070.4 1079.7 11274.2 11844.2 11951.8 11996.7 11997.3 4834.0 4840.5 4850.6 4979.3 5023.9 10079.0 10100.4 10111.5 10119.9 10152.0 5554.4 5563.0 5577.3 5578.4 5579.0 4484.5 4895.8 4992.0 4993.8 5057.4 3842.8 3955.6 3964.8 3982.2 4003.0 1030.1 1340.6 1351.3 1361.8 1373.6 1187.4 1325.5 1356.9 1386.7 1387.0 8178.6 8365.5 8373.2 8395.3 8396.0 1180.6 1199.5 1218.5 1222.6 1227.2 5284.9 6328.1 6376.1 6470.6 6481.1 10347.5 10668.5 10718.0 10751.5 10839.9 10522.9 10737.6 10762.4 10846.2 10861.8 8372.2 8458.5 8529.4 8547.7 8589.7 7927.2 7969.8 7985.1 7997.5 8093.6 9481.1 9689.0 9715.4 9773.8 9829.7 9876.7 10034.1 10195.9 10355.2 10396.3 7005.9 7118.4 7206.9 7472.1 7519.4 8202.6 8223.3 8290.5 8302.8 8415.8 7276.8 7333.4 7377.1 7557.4 7563.5 7108.7 7132.6 7195.3 7200.6 7205.2 7532.2 7629.5 7631.2 7642.2 7675.4 6848.4 6881.0 6895.7 6975.3 6988.3 7104.7 7122.9 7141.3 7160.4 7172.0 05:50:08 INFO - PROCESS | 1658 | 05:50:08 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:6020.67 Median:6813.92 stddev:1952.15 (28.6%) stddev-sans-first:1910.28 05:50:08 INFO - PROCESS | 1658 | Values: 326.9 327.4 330.6 332.6 335.7 6008.8 6434.1 6840.1 6910.8 6945.3 6773.2 6801.1 6826.7 6834.5 6888.1 4774.8 4902.3 5003.4 5021.4 5097.0 4368.9 4442.6 5046.2 5051.0 5060.7 4293.0 5021.7 5049.8 5062.4 5077.9 4403.2 4701.6 5037.2 5042.2 5062.0 3535.8 4284.2 4296.2 4299.3 4302.3 6405.1 6652.4 6695.9 6707.8 6708.2 5861.0 5934.3 5944.8 5978.0 6020.1 7336.4 7366.2 7366.7 7373.9 7398.6 4604.0 4840.0 4853.1 4855.6 4863.2 6694.5 7834.1 7840.8 7849.9 7867.6 4739.5 4920.7 4925.2 4932.0 4946.5 4989.9 5020.5 5037.7 5041.5 5046.5 5914.1 5970.3 5975.6 5981.6 5986.4 7401.3 7411.0 7423.6 7431.8 7436.0 1728.0 1756.1 1758.2 1761.7 1763.9 1083.1 1134.2 1136.9 1138.1 1139.8 5307.6 5866.2 6878.7 6905.5 6972.5 7391.9 7625.1 7637.8 7657.0 7689.0 6650.7 6752.2 6885.2 6893.4 6893.7 4053.6 4087.2 4094.4 4111.2 4114.3 6870.4 8088.5 8106.8 8107.0 8137.4 7753.8 7922.2 7992.8 8011.0 8032.6 8038.2 8072.9 8092.7 8113.3 8138.7 7712.1 7712.8 7722.7 7727.5 7747.6 7579.3 7598.5 7609.3 7648.6 7652.8 7838.8 8032.8 8098.0 8113.7 8160.6 4740.6 4745.6 4774.9 4776.9 4803.9 7665.5 7701.8 7711.3 7712.4 7715.5 5995.6 7410.9 7428.7 7434.7 7480.1 7032.0 7418.7 7423.6 7433.3 7454.4 7218.1 7260.4 7275.7 7279.0 7286.6 7403.5 7410.4 7414.4 7436.9 7439.8 6302.7 6903.6 6919.3 7231.9 7241.1 05:50:08 INFO - PROCESS | 1658 | 05:50:08 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:17609.44 Median:31323.90 stddev:24602.12 (78.5%) stddev-sans-first:24638.24 05:50:08 INFO - PROCESS | 1658 | Values: 665.9 668.1 696.2 756.8 758.8 14395.0 14665.2 14727.3 14743.8 14760.6 15226.2 15657.1 15700.8 15707.9 15712.2 749.3 931.8 932.4 946.8 947.9 897.6 898.4 936.6 936.6 939.2 993.5 994.7 998.3 999.8 1000.2 950.2 978.5 982.3 985.9 988.0 707.3 730.2 731.5 733.4 734.3 13433.6 15180.3 15202.7 15234.7 15384.6 12367.0 12392.9 12424.9 12598.2 12646.4 9921.5 9992.5 10423.4 10479.1 10684.0 3414.2 3445.0 3528.3 3529.5 3535.9 74326.0 75451.0 77089.6 79806.0 80316.0 9255.3 9366.7 9389.3 9397.7 9448.1 20588.7 20767.0 20846.4 20978.9 21282.6 7241.4 7348.7 7433.9 7436.5 7679.8 3998.2 4004.8 4080.7 4085.2 4088.6 3587.5 3624.6 3631.8 3641.5 3646.7 643.5 655.2 658.4 665.9 669.1 415.4 522.2 545.4 586.5 587.1 8152.6 8277.2 8308.1 8409.6 8427.2 432.4 584.8 605.2 626.0 628.4 3152.0 3821.9 3847.6 3878.4 3918.3 85782.0 93123.1 96626.0 96674.0 96742.0 75625.3 76288.0 77058.0 78118.8 78290.6 62021.8 65400.7 70090.6 70468.2 70725.0 7940.2 8197.2 8228.3 8413.1 8552.7 43915.9 44091.3 44287.0 44717.0 45891.0 47815.3 51398.2 51447.7 57241.0 62773.0 10430.4 10511.8 10842.6 11004.5 11046.0 9763.3 11754.1 11805.6 11910.9 12019.8 11085.4 11103.0 11203.2 11223.0 11299.7 11161.4 11184.8 11278.4 11293.6 11764.5 10953.8 11158.3 11372.2 11403.5 11604.5 9471.9 9537.1 9554.8 9626.0 9782.7 9012.3 9502.1 9590.1 9593.7 9763.1 05:50:08 INFO - PROCESS | 1658 | -------- Summary: end -------- 05:50:08 INFO - PROCESS | 1658 | 05:50:08 INFO - TEST-INFO | 1658: exit 0 05:50:08 INFO - TEST-OK | dromaeo_css | took 1110637ms 05:50:08 INFO - TEST-START | kraken 05:50:08 INFO - operating with platform_type : mac_ 05:50:08 INFO - Initialising browser for kraken test... 05:50:08 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpm9brUJ/profile http://localhost:49272/getInfo.html) 05:50:11 INFO - PROCESS | 1669 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:50:11 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 05:50:11 INFO - PROCESS | 1669 | colorDepth:24 05:50:11 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 05:50:11 INFO - PROCESS | 1669 | __metrics 05:50:11 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 05:50:12 INFO - TEST-INFO | 1669: exit 0 05:50:12 INFO - Browser initialized. 05:50:12 INFO - Running cycle 1/1 for kraken test... 05:50:12 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpm9brUJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:24 INFO - PROCESS | 1672 | RSS: Main: 246898688 05:50:24 INFO - PROCESS | 1672 | 05:50:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 05:50:27 INFO - PROCESS | 1672 | RSS: Main: 258957312 05:50:27 INFO - PROCESS | 1672 | 05:50:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 05:50:30 INFO - PROCESS | 1672 | RSS: Main: 268300288 05:50:30 INFO - PROCESS | 1672 | 05:50:34 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 05:50:34 INFO - PROCESS | 1672 | RSS: Main: 271319040 05:50:34 INFO - PROCESS | 1672 | 05:50:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 05:50:37 INFO - PROCESS | 1672 | RSS: Main: 272097280 05:50:37 INFO - PROCESS | 1672 | 05:50:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:40 INFO - PROCESS | 1672 | RSS: Main: 272625664 05:50:40 INFO - PROCESS | 1672 | 05:50:42 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:43 INFO - PROCESS | 1672 | RSS: Main: 273891328 05:50:43 INFO - PROCESS | 1672 | 05:50:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:47 INFO - PROCESS | 1672 | RSS: Main: 273461248 05:50:47 INFO - PROCESS | 1672 | 05:50:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 05:50:50 INFO - PROCESS | 1672 | RSS: Main: 274763776 05:50:50 INFO - PROCESS | 1672 | 05:50:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:52 INFO - PROCESS | 1672 | RSS: Main: 273965056 05:50:52 INFO - PROCESS | 1672 | 05:50:54 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:55 INFO - PROCESS | 1672 | RSS: Main: 274182144 05:50:55 INFO - PROCESS | 1672 | 05:50:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:58 INFO - PROCESS | 1672 | RSS: Main: 274259968 05:50:58 INFO - PROCESS | 1672 | 05:51:00 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:51:01 INFO - PROCESS | 1672 | RSS: Main: 274579456 05:51:01 INFO - PROCESS | 1672 | 05:51:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:51:04 INFO - PROCESS | 1672 | RSS: Main: 274493440 05:51:04 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 05:51:06 INFO - PROCESS | 1672 | RSS: Main: 276086784 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | __start_tp_report 05:51:06 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 05:51:06 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 05:51:06 INFO - PROCESS | 1672 | |i|pagename|runs| 05:51:06 INFO - PROCESS | 1672 | |0;ai-astar;115;109;119;153;102;184;167;170;117;116 05:51:06 INFO - PROCESS | 1672 | |1;audio-beat-detection;158;126;146;159;124;145;141;118;164;123 05:51:06 INFO - PROCESS | 1672 | |2;audio-dft;195;197;200;209;230;218;199;202;197;201 05:51:06 INFO - PROCESS | 1672 | |3;audio-fft;57;56;69;70;68;123;57;60;58;60 05:51:06 INFO - PROCESS | 1672 | |4;audio-oscillator;82;96;155;117;80;83;101;110;119;165 05:51:06 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;80;128;128;87;89;92;90;87;92;89 05:51:06 INFO - PROCESS | 1672 | |6;imaging-darkroom;148;121;95;96;96;96;116;94;110;123 05:51:06 INFO - PROCESS | 1672 | |7;imaging-desaturate;90;94;91;92;92;91;93;90;92;100 05:51:06 INFO - PROCESS | 1672 | |8;json-parse-financial;53;49;77;44;47;56;74;91;91;85 05:51:06 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;66;68;58;95;109;105;92;67;81;88 05:51:06 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;87;84;97;86;86;85;103;112;82;88 05:51:06 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;138;147;146;123;135;140;144;151;115;133 05:51:06 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;131;141;144;144;142;134;136;179;183;174 05:51:06 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;69;66;69;66;75;56;61;101;95;98 05:51:06 INFO - PROCESS | 1672 | __end_tp_report 05:51:06 INFO - PROCESS | 1672 | __start_cc_report 05:51:06 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,972 05:51:06 INFO - PROCESS | 1672 | __end_cc_report 05:51:06 INFO - PROCESS | 1672 | __startTimestamp1459774266852__endTimestamp 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | ------- Summary: start ------- 05:51:06 INFO - PROCESS | 1672 | Number of tests: 14 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:135.20 Median:136.00 stddev:29.96 (22.0%) stddev-sans-first:30.88 05:51:06 INFO - PROCESS | 1672 | Values: 115.0 109.0 119.0 153.0 102.0 184.0 167.0 170.0 117.0 116.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:145.50 stddev:16.82 (11.6%) stddev-sans-first:16.59 05:51:06 INFO - PROCESS | 1672 | Values: 158.0 126.0 146.0 159.0 124.0 145.0 141.0 118.0 164.0 123.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:204.80 Median:201.50 stddev:11.17 (5.5%) stddev-sans-first:11.27 05:51:06 INFO - PROCESS | 1672 | Values: 195.0 197.0 200.0 209.0 230.0 218.0 199.0 202.0 197.0 201.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:67.80 Median:60.00 stddev:20.12 (33.5%) stddev-sans-first:20.96 05:51:06 INFO - PROCESS | 1672 | Values: 57.0 56.0 69.0 70.0 68.0 123.0 57.0 60.0 58.0 60.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:122.50 stddev:29.56 (24.1%) stddev-sans-first:29.46 05:51:06 INFO - PROCESS | 1672 | Values: 82.0 96.0 155.0 117.0 80.0 83.0 101.0 110.0 119.0 165.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:89.00 stddev:17.10 (19.2%) stddev-sans-first:17.10 05:51:06 INFO - PROCESS | 1672 | Values: 80.0 128.0 128.0 87.0 89.0 92.0 90.0 87.0 92.0 89.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:109.50 Median:94.50 stddev:17.75 (18.8%) stddev-sans-first:12.19 05:51:06 INFO - PROCESS | 1672 | Values: 148.0 121.0 95.0 96.0 96.0 96.0 116.0 94.0 110.0 123.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:92.50 Median:92.00 stddev:2.92 (3.2%) stddev-sans-first:2.95 05:51:06 INFO - PROCESS | 1672 | Values: 90.0 94.0 91.0 92.0 92.0 91.0 93.0 90.0 92.0 100.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:75.50 stddev:18.84 (25.0%) stddev-sans-first:19.32 05:51:06 INFO - PROCESS | 1672 | Values: 53.0 49.0 77.0 44.0 47.0 56.0 74.0 91.0 91.0 85.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:82.90 Median:74.50 stddev:17.67 (23.7%) stddev-sans-first:17.65 05:51:06 INFO - PROCESS | 1672 | Values: 66.0 68.0 58.0 95.0 109.0 105.0 92.0 67.0 81.0 88.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:86.00 stddev:9.79 (11.4%) stddev-sans-first:10.27 05:51:06 INFO - PROCESS | 1672 | Values: 87.0 84.0 97.0 86.0 86.0 85.0 103.0 112.0 82.0 88.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:142.00 stddev:11.23 (7.9%) stddev-sans-first:11.91 05:51:06 INFO - PROCESS | 1672 | Values: 138.0 147.0 146.0 123.0 135.0 140.0 144.0 151.0 115.0 133.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:144.00 stddev:19.80 (13.8%) stddev-sans-first:19.67 05:51:06 INFO - PROCESS | 1672 | Values: 131.0 141.0 144.0 144.0 142.0 134.0 136.0 179.0 183.0 174.0 05:51:06 INFO - PROCESS | 1672 | 05:51:06 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:69.00 stddev:16.30 (23.6%) stddev-sans-first:17.12 05:51:06 INFO - PROCESS | 1672 | Values: 69.0 66.0 69.0 66.0 75.0 56.0 61.0 101.0 95.0 98.0 05:51:06 INFO - PROCESS | 1672 | -------- Summary: end -------- 05:51:06 INFO - PROCESS | 1672 | 05:51:07 INFO - TEST-INFO | 1672: exit 0 05:51:07 INFO - TEST-OK | kraken | took 58845ms 05:51:07 INFO - SUITE-END | took 1169s 05:51:07 INFO - Completed test suite (00:19:29) 05:51:07 INFO - javascript benchmark 05:51:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2818.3517790908104, 3245.561849150364, 3561.9465708014386, 3576.606573276939, 3626.329129111113, 5855.23881895354, 5878.353381128078, 5891.88216235675, 5905.173275741389, 5981.072933695274, 5808.767649294034, 5939.0794426863795, 5953.553483488734, 6024.9096263555975, 6044.607100538473, 5250.7637156328055, 5327.360716713981, 5354.518093371596, 5361.705106219157, 5376.731163441832, 193.0508892241301, 5292.391374991887, 5312.574994000471, 5366.275552800361, 5411.512963833255, 4464.620507256887, 5302.734863256841, 5302.814401495948, 5320.441353657888, 5330.413654498002, 5238.978399212155, 5346.251524786533, 5352.464753524655, 5355.357357117132, 5384.434634363374, 5224.686518808883, 5225.477452254782, 5292.655977361498, 5304.336957880265, 5362.758675859557, 5188.325517682715, 5242.842714718565, 5768.855778605526, 5849.33294011209, 5876.823695289148, 6134.834601026134, 6239.157713708637, 6283.497320214372, 6298.212723409574, 6301.338359472235, 6251.437370636619, 6328.240611126648, 6328.683565821737, 6329.272133704637, 6346.365363463663, 5994.760209591611, 5997.880042399128, 6017.578769486137, 6020.939790602081, 6025.9397406026255, 6226.315105338409, 6353.714082866282, 6390.265119511223, 6423.0686550450855, 6444.516661250425, 6242.968785156045, 6285.497160227171, 6308.728857611256, 6320.146780184708, 6333.809985700436, 6253.843653908689, 6275.309715931244, 6307.873842523124, 6310.5898116622275, 6327.651979141099, 6168.228971378578, 6224.221972253468, 6280.214973128359, 6283.151774510474, 6288.779892703734, 5182.170852663556, 6069.423404776539, 6268.404501572434, 6280.780172693934, 6284.654344011124, 4954.529319714621, 5005.649604527648, 5011.123053465702, 5015.623828212899, 5032.446430892599, 4451.154280686659, 4455.643548516111, 4514.074614703978, 4544.2047641662575, 4563.338315944236, 5944.64332140073, 5969.522438204933, 5989.431004054608, 6010.459058684739, 6012.158297838306, 6290.559660823698, 6295.874082518416, 6306.905396419057, 6313.494920406357, 6323.620582765049, 4924.975375123101, 5865.912011319833, 5955.3151387590115, 6031.125486804389, 6047.909281360783, 5477.945220547744, 5481.945180548143, 5489.890202195934, 5495.835124946258, 5510.5316048135555, 5868.325142608569, 6230.813075607739, 6344.429001389897, 6514.413702766774, 6527.804165875032, 6197.977333739883, 6264.718087685974, 6273.121762953099, 6304.71628776697, 6311.053341998737, 6301.306856245901, 6472.0, 6473.190851143607, 6523.902141467787, 6525.771597994048, 6137.96931015342, 6236.095766113979, 6257.7184026719815, 6274.027525733519, 6326.43062124411, 6229.2524897012645, 6264.624122552661, 6277.497800175884, 6283.434490895658, 6300.1809764732125, 5599.664020158803, 6210.975189093749, 6243.500519958302, 6259.0, 6273.905891411541, 6122.877542449037, 6132.540059495466, 6194.256689197326, 6243.469305109116, 6275.466585340298, 5651.660900345993, 5808.664007278265, 6114.206128133811, 6133.049377346519, 6186.10301506288, 5020.3724534433195, 6165.907511387422, 6229.4393504582995, 6270.874582508233, 6279.215098112736, 6065.4541091302, 6081.817545473643, 6112.847178820387, 6146.661933593696, 6178.289496707756], "unit": "score", "name": "dojo.html", "value": 5740.555999510224}, {"lowerIsBetter": false, "replicates": [424.92351376752174, 583.6882789083451, 603.81953281335, 604.6553464525217, 625.7497001199521, 37579.0, 38224.617753822524, 38270.42594361083, 38275.80862095692, 38526.61473385265, 41267.9683007925, 41298.0, 41613.0, 42173.0, 42191.578084219145, 9515.809683806337, 9705.805883882318, 9715.271354648394, 9722.854157187649, 9723.367981081243, 9520.42877427353, 9559.904400956006, 9572.664956726516, 9640.662576809813, 9700.854487182698, 9659.758506037335, 9678.951605241964, 9696.709098727015, 9716.902830971705, 9745.951270243639, 9549.379290346105, 9593.47235902025, 9648.951755241249, 9688.934217236098, 9701.757456063584, 9493.240540756791, 9559.856602150974, 9621.615135394575, 9641.614335426575, 9671.468069256189, 32769.836150819334, 39535.40696889549, 39945.0, 39956.200875982315, 39999.80000599987, 3087.5677405163296, 3147.291859331632, 3298.8515516801804, 3300.339932013607, 3313.1054615253747, 27315.590266146024, 27615.44769104627, 27794.0, 28340.43319133606, 28374.574381384296, 2726.5910113482937, 2781.9304517387027, 2785.7632101271415, 2898.695636958131, 2960.067578712699, 342079.0, 345236.0, 346311.0, 348878.0, 349707.2514637436, 46538.5346146541, 68054.65972670105, 68498.0, 68526.91628876713, 69120.0, 45892.311615325794, 46016.30975535369, 46044.769776151574, 46049.30926036112, 46460.0, 15751.369945202063, 15765.132917689407, 15839.970401923838, 15928.884978051658, 16004.839951600568, 10551.84172237417, 12513.937430312972, 12663.050271229695, 12689.873101269053, 12720.363981800872, 14918.92540537312, 15028.549143525712, 15058.924705376403, 15182.924085379502, 15209.163496007826, 6398.552101352953, 6512.153420055457, 6535.150430444012, 6539.607623542603, 6555.704993275314, 823.4153750836973, 948.2035090523993, 959.6976952260015, 1030.7886883188928, 1031.6698656429871, 28736.850525978727, 28850.0, 29605.932098306264, 29648.2587935299, 30116.247093822392, 1066.2376400873413, 1079.4440862955585, 1088.2599832114238, 1099.934003959749, 1174.1956759619688, 15070.849291507164, 15108.320125594375, 15121.017133886262, 15586.454474093352, 15637.452689155825, 539769.0, 720078.0, 738430.0, 741350.0, 746097.0, 61661.38338616646, 61907.690461547405, 62613.68693156505, 62762.686186568775, 62859.0, 1480.9111453312835, 1493.8580834820675, 1494.036346556465, 1502.1738044075714, 1509.7433436315853, 30373.39253214879, 30672.386552269276, 30767.076987690405, 31032.22419439532, 32357.029289121365, 54607.453925460235, 54766.904661907334, 54957.72521137369, 54985.450145498035, 55006.44993550173, 499544.0, 500221.4988925032, 502065.0, 506051.0, 507611.0, 34908.82545587256, 46895.0, 47477.52522474731, 47754.0, 48515.0, 47941.0, 48185.03629927312, 48264.517354826, 50056.499435005186, 50162.247566285805, 34130.146746330545, 41672.3749143757, 41887.09413125812, 42021.73934781962, 43768.343474847265, 40840.38739418852, 41330.586694132675, 41399.58600413957, 41607.37588936108, 42262.788686056374, 40343.596564033985, 40950.795246023576, 41126.0, 41645.58354416417, 42052.0, 39266.80366598263, 40283.3957490632, 40872.97817554466, 41213.79393103015, 41772.0, 25549.3612659685, 26131.73868261293, 26241.73758262393, 26344.967051358257, 26476.338091547095], "unit": "score", "name": "ext.html", "value": 19948.55812991669}, {"lowerIsBetter": false, "replicates": [331.49281599153295, 359.2043623374227, 364.4605983144945, 368.24142266930124, 372.52689084862243, 19342.41972740818, 19493.610127797434, 20046.29837955672, 20113.19547218113, 20171.19315227391, 18466.0, 18833.0, 20086.69869951952, 20420.489487762814, 20617.1753129875, 4883.487233840449, 5273.920891186635, 5829.708514574276, 5884.764609415618, 5986.3415024347505, 4209.936850947238, 5792.565557583177, 6201.0, 6464.676766161697, 6482.448991835699, 6395.840103997414, 6417.101605775195, 6428.517861160408, 6430.906745853216, 6433.163688720483, 5007.949920500785, 5750.25246717924, 5754.194412782193, 5774.249347584787, 5791.942080579182, 5268.631195816294, 5470.261514695505, 5474.288342515487, 5527.585431092684, 5532.7786888524415, 13024.86975130246, 13295.135816171918, 13356.131851429724, 13472.393742281523, 13483.258420786853, 1725.585859393749, 2001.549651328454, 2109.003438484079, 2134.4557137929883, 2175.086463685256, 7973.362131029504, 9363.906360936371, 10183.949080254626, 11129.72175695606, 14745.959754716276, 1675.4973507947566, 1699.9205504504605, 1737.4527023987403, 1755.1926113987581, 1776.1030679506896, 72370.27629723688, 74442.62778686071, 74719.62640186764, 84180.99999999939, 94902.0, 10676.252662313718, 11048.0, 11143.2199746017, 11164.274322169033, 11271.943640281746, 13561.186328820302, 13650.863491364958, 13681.452741890413, 13686.247256400993, 13721.862781372258, 8342.37432192588, 8514.48913065218, 8526.701565445179, 8538.53038082899, 8553.401261911606, 7964.646010178168, 8663.956680216685, 8682.6092825823, 8689.522076285739, 8755.592212141712, 3574.7855128692363, 4129.2773764591075, 4391.692581519327, 4396.164728701537, 4413.183561041154, 1722.6382459683607, 1803.4138904855974, 1816.273490603769, 1898.572821115238, 1905.514093906045, 890.8841850559386, 954.1222075690381, 955.9761005974767, 967.0281367226033, 981.4160574458186, 18993.33523326677, 19759.0, 19765.110570024382, 19900.104495297746, 20013.499662508555, 857.4598003257908, 939.6664184214642, 947.275334369208, 1000.1248907206194, 1009.4902074452355, 8511.702090426805, 10741.570337186426, 10997.835032474519, 11011.83482247767, 11054.944725276322, 604190.0, 609593.0, 613809.9309503424, 623160.0, 623321.0, 98787.0, 120041.0, 120119.0, 120613.79386206201, 120629.19056214164, 451.4965813118415, 468.23911144390365, 468.9413823272091, 469.5586149019979, 471.49785478465327, 9110.863337050083, 10351.327163734333, 11177.441127943408, 17537.473875783748, 18305.359312424, 42799.35800962926, 49003.0, 49223.0, 53552.19671705006, 53607.731961339945, 67556.66221668861, 68169.65915170392, 68799.0, 68903.0, 69349.65325173341, 7762.262585054411, 7917.604119793872, 8001.759947201594, 8048.114707382067, 8279.917200827915, 12187.939060304641, 12239.938800305941, 12435.0, 12647.0, 12780.808287875503, 10243.334183278062, 10699.89300106989, 10874.565017399533, 10898.618548350769, 10929.672109836718, 10577.735556611146, 10738.46307684597, 10747.623833165802, 10816.459177040959, 11096.722581935193, 11070.667879963614, 11085.168612353944, 11163.49764260594, 11193.384363859741, 11436.485358158736, 6117.663528505975, 7889.763307100796, 8010.519368837889, 8106.432549721699, 8155.469894456842, 7019.298070193144, 9695.66065187715, 11039.172062095535, 11061.778764424505, 11158.665240042812], "unit": "score", "name": "jquery.html", "value": 8756.262706758453}, {"lowerIsBetter": false, "replicates": [1596.3215633355824, 1603.4548253593775, 1882.962340753185, 1962.8822270663752, 1980.7226988221641, 7925.128235894047, 8433.819265302862, 8720.8691869622, 8969.865452018224, 8976.057513961037, 7261.963690181555, 8660.523671198082, 8731.432456890314, 8779.824403511926, 8792.604332805024, 2477.4178068154015, 2505.8747062646885, 2506.686664166979, 2515.05685367987, 2515.346010037385, 1955.9413217603494, 2068.079704531484, 2442.682451281331, 2509.335026218054, 2512.6984761828517, 2127.7872212778675, 2453.092355828346, 2464.3346296499935, 2469.777720005199, 2525.7600527949908, 2484.254723582918, 2496.5131799299143, 2512.836665616738, 2518.6851643544555, 2537.0486067724605, 2495.6131799571094, 2496.6879140107485, 2498.362917456037, 2504.2362079565723, 2505.3736565858535, 8921.910780892173, 8936.865947010736, 8952.776180595472, 8973.147550982647, 8980.8652870207, 5275.472452754732, 5363.088274993261, 5389.730513474311, 5399.217113518557, 5412.943081628995, 3585.229175727205, 3670.7981061041633, 3718.6653201211752, 3732.328180927432, 3739.8878033659034, 1045.3362115056918, 1061.0027069425428, 1064.1912146768434, 1070.4433694478905, 1079.6922876980102, 11274.154438417152, 11844.230125041844, 11951.760964780655, 11996.70008249792, 11997.280163190237, 4834.0, 4840.467548569654, 4850.6362022848425, 4979.3277907482025, 5023.874403139877, 10079.042490963348, 10100.393976361294, 10111.494425278706, 10119.898801011896, 10152.0, 5554.389017208104, 5563.026470367669, 5577.274954256002, 5578.386377498472, 5579.0, 4484.529124441952, 4895.804167833318, 4991.97664478781, 4993.775280112403, 5057.367829021372, 3842.769433833979, 3955.624215699504, 3964.801759911993, 3982.183652351319, 4002.959970400317, 1030.1192480429274, 1340.604521666111, 1351.3243378310844, 1361.8297712785902, 1373.5810577773875, 1187.3647598534915, 1325.516186591887, 1356.945722171102, 1386.7157232767258, 1387.0221493846814, 8178.550179740171, 8365.539895305817, 8373.162683731578, 8395.328373730086, 8395.95802020986, 1180.6458062581362, 1199.5082016373244, 1218.4821450883517, 1222.6332100369852, 1227.1777908801125, 5284.947150528523, 6328.082428047907, 6376.107344971708, 6470.64411457365, 6481.125048118538, 10347.534360953776, 10668.466576671135, 10718.0, 10751.51618177184, 10839.891601084046, 10522.947385263025, 10737.624183153552, 10762.408067556204, 10846.240763146505, 10861.83707244392, 8372.162783721578, 8458.534780587004, 8529.445586037013, 8547.74356769298, 8589.742307730654, 7927.246911543394, 7969.8406031880195, 7985.121636619851, 7997.520148791091, 8093.635786389509, 9481.051894810464, 9689.0, 9715.417074975525, 9773.755656108655, 9829.655962041294, 9876.703698889045, 10034.147097496794, 10195.949020254851, 10355.17158627323, 10396.272260941661, 7005.859882802417, 7118.359347658528, 7206.89189662166, 7472.103347598323, 7519.360854327443, 8202.589870506332, 8223.259906608433, 8290.544020078954, 8302.792430189294, 8415.831683366421, 7276.818079548054, 7333.376662983706, 7377.077865266841, 7557.395408367208, 7563.546187228784, 7108.715651374094, 7132.643367831484, 7195.316444937723, 7200.603966781878, 7205.207427182901, 7532.171461139161, 7629.504082234637, 7631.236876312324, 7642.235776422313, 7675.424343174396, 6848.383645471931, 6880.9655951721925, 6895.6552172392185, 6975.3024697529845, 6988.336108069725, 7104.680289387094, 7122.928770712227, 7141.321574450419, 7160.391366733886, 7171.964140179266], "unit": "score", "name": "mootools.html", "value": 4989.449799644181}, {"lowerIsBetter": false, "replicates": [326.9150020994542, 327.3698131097637, 330.6214384529712, 332.622473492586, 335.7398016537184, 6008.849778755533, 6434.0670602762575, 6840.144981877265, 6910.827229319276, 6945.305469453052, 6773.221079575838, 6801.115854938864, 6826.726930922757, 6834.487413443987, 6888.138982627159, 4774.7612619369065, 4902.264660300948, 5003.424606170301, 5021.397432308128, 5097.031564002837, 4368.907773056736, 4442.600165985061, 5046.243063540462, 5051.0, 5060.671056381342, 4292.97853510732, 5021.748912554376, 5049.798008079672, 5062.367204099488, 5077.873053173664, 4403.207422663919, 4701.647376446763, 5037.244413337992, 5042.168042273021, 5062.0, 3535.840887160058, 4284.207421627009, 4296.162248361571, 4299.290617048183, 4302.311630139194, 6405.135306733578, 6652.368025037662, 6695.866082678368, 6707.7652282170375, 6708.19501659804, 5860.970695146497, 5934.258217722785, 5944.762209511614, 5978.0, 6020.127081573148, 7336.376408005326, 7366.152892417387, 7366.742164024287, 7373.926260737378, 7398.593077380742, 4603.953960460386, 4839.951600483985, 4853.0779151961015, 4855.63582731293, 4863.2461968394955, 6694.531382803206, 7834.1382447931255, 7840.764777056697, 7849.882251766228, 7867.645955932054, 4739.526047395302, 4920.72935988524, 4925.162722337212, 4931.988942266827, 4946.5053494650965, 4989.925151122736, 5020.472850350734, 5037.672551284155, 5041.521055499722, 5046.470120637354, 5914.112883067488, 5970.313413957364, 5975.55183361241, 5981.551383646244, 5986.371430999682, 7401.259874012663, 7411.036565246483, 7423.591702456309, 7431.777046688608, 7436.0, 1727.991360043217, 1756.1307152959366, 1758.164871685939, 1761.744547040672, 1763.9206235719423, 1083.106437189322, 1134.2287244673537, 1136.8976792088752, 1138.1009002887793, 1139.7777433400572, 5307.62846600742, 5866.2373891393845, 6878.69045892936, 6905.516613836983, 6972.51192416526, 7391.930259527341, 7625.084989801259, 7637.770866874002, 7656.961715191388, 7688.961555192188, 6650.70071846768, 6752.223494298219, 6885.242623311432, 6893.4140598048725, 6893.724251029903, 4053.5541090480024, 4087.2438598859308, 4094.3653733671326, 4111.177764447122, 4114.259433301974, 6870.416014638712, 8088.474249173785, 8106.797330066677, 8106.959465202636, 8137.430379873352, 7753.806154846174, 7922.247386498273, 7992.760217193493, 8011.0, 8032.598370081472, 8038.155993620586, 8072.878906816285, 8092.71675491355, 8113.310368618615, 8138.715144969898, 7712.074551053685, 7712.807179820549, 7722.7297044603165, 7727.536347819148, 7747.612619369122, 7579.317861392501, 7598.466712978491, 7609.315161635479, 7648.579328137006, 7652.80867978305, 7838.764837054898, 8032.759017229492, 8097.959510202411, 8113.6754529818145, 8160.591970401338, 4740.5733483986605, 4745.644076694331, 4774.880627984328, 4776.928346074881, 4803.927941080957, 7665.540067595962, 7701.807454813675, 7711.344535714527, 7712.383009359126, 7715.537067775951, 5995.550333724901, 7410.888836667562, 7428.665710042953, 7434.702611895464, 7480.102387713509, 7031.964840175767, 7418.66616002292, 7423.591702456417, 7433.256674332523, 7454.403647708279, 7218.097737782778, 7260.419166466564, 7275.672594733144, 7279.0, 7286.635668216462, 7403.51877127985, 7410.370118539984, 7414.406847452083, 7436.851262974818, 7439.776806695808, 6302.71637776292, 6903.6203008835, 6919.342662447059, 7231.891521627285, 7241.13106427211], "unit": "score", "name": "prototype.html", "value": 5367.873989632693}, {"lowerIsBetter": false, "replicates": [665.9167604049495, 668.0647094068304, 696.2028477393385, 756.8259300360917, 758.772368289513, 14395.0, 14665.193414362206, 14727.263636818156, 14743.820494360452, 14760.557183284493, 15226.162561059138, 15657.138857362841, 15700.842991570082, 15707.921460392681, 15712.214389280547, 749.3405802893446, 931.7514530529123, 932.3986029011301, 946.7727745341103, 947.8815148106487, 897.640943622553, 898.3890954151175, 936.5738588942049, 936.625349860058, 939.2486011191054, 993.4734590666922, 994.6717583197527, 998.2912132386015, 999.7500624843789, 1000.174855744014, 950.2065775077818, 978.5156347607945, 982.3418309732497, 985.9014098590084, 987.9851802223009, 707.3033062433499, 730.2478447199393, 731.4550659758514, 733.4205977277944, 734.3244215321863, 13433.596992090155, 15180.316885740169, 15202.695946081127, 15234.695306093927, 15384.615384615363, 12367.0, 12392.938035309766, 12424.937875310565, 12598.244105353708, 12646.367681615882, 9921.50392480373, 9992.500374981222, 10423.374597524173, 10479.056884880398, 10684.0, 3414.2488652496413, 3444.9827750861336, 3528.259065596228, 3529.541159649229, 3535.9116022099397, 74326.0, 75451.0, 77089.61455192744, 79806.0, 80316.0, 9255.259579233645, 9366.718998430058, 9389.342746007715, 9397.718068457958, 9448.149666530046, 20588.691169632468, 20767.0, 20846.374608761762, 20978.895105524374, 21282.574348512942, 7241.42068634508, 7348.678006356699, 7433.85132297351, 7436.516626419266, 7679.846403071907, 3998.1803730235233, 4004.799760011988, 4080.6939479539155, 4085.22380747657, 4088.632023117934, 3587.5336206293014, 3624.5831729350934, 3631.763935344194, 3641.5266015417824, 3646.7082633389264, 643.5077165968038, 655.1548502431905, 658.4074333100248, 665.8867992441296, 669.1434963247052, 415.4453804171405, 522.2062465053098, 545.427301333606, 586.4985437451003, 587.1310460518457, 8152.551609661407, 8277.172282771675, 8308.12764659714, 8409.579521023925, 8427.157284271647, 432.4464685202945, 584.7602482981957, 605.1751888077256, 626.0484064222356, 628.446966669328, 3152.0, 3821.885343439701, 3847.634474724897, 3878.3600705883214, 3918.2555314490155, 85782.0, 93123.0687693128, 96626.0, 96674.0, 96742.0, 75625.32810039159, 76288.0, 77058.0, 78118.82821757678, 78290.6085469569, 62021.759564809356, 65400.67299663471, 70090.64954675194, 70468.23829404305, 70725.0, 7940.205979402013, 8197.180281971756, 8228.25945664893, 8413.07456179832, 8552.657893684183, 43915.90210244642, 44091.338629919934, 44287.0, 44717.0, 45891.0, 47815.28277075777, 51398.20106296262, 51447.713807153625, 57241.0, 62773.0, 10430.426326552113, 10511.842322365324, 10842.620508282173, 11004.504797284302, 11045.950634689692, 9763.267754918268, 11754.11844111678, 11805.586804461802, 11910.880891190976, 12019.819702704292, 11085.390433238199, 11103.0, 11203.21577489568, 11222.989930906258, 11299.717507062389, 11161.441927903736, 11184.832227516432, 11278.436078195893, 11293.604723834625, 11764.470598822902, 10953.83569246478, 11158.330500170016, 11372.20394572372, 11403.543858245577, 11604.535818567163, 9471.905280947103, 9537.14165725088, 9554.808903821746, 9626.0, 9782.706518804447, 9012.2790176787, 9502.097300756417, 9590.08894155082, 9593.712188634352, 9763.072508111718], "unit": "score", "name": "yui.html", "value": 6821.015625756078}], "name": "dromaeo_css", "value": 7536.219204260638}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 119.0, 153.0, 102.0, 184.0, 167.0, 170.0, 117.0, 116.0], "unit": "score", "name": "ai-astar", "value": 135.2}, {"lowerIsBetter": true, "replicates": [158.0, 126.0, 146.0, 159.0, 124.0, 145.0, 141.0, 118.0, 164.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 140.4}, {"lowerIsBetter": true, "replicates": [195.0, 197.0, 200.0, 209.0, 230.0, 218.0, 199.0, 202.0, 197.0, 201.0], "unit": "score", "name": "audio-dft", "value": 204.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 69.0, 70.0, 68.0, 123.0, 57.0, 60.0, 58.0, 60.0], "unit": "score", "name": "audio-fft", "value": 67.8}, {"lowerIsBetter": true, "replicates": [82.0, 96.0, 155.0, 117.0, 80.0, 83.0, 101.0, 110.0, 119.0, 165.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [80.0, 128.0, 128.0, 87.0, 89.0, 92.0, 90.0, 87.0, 92.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.2}, {"lowerIsBetter": true, "replicates": [148.0, 121.0, 95.0, 96.0, 96.0, 96.0, 116.0, 94.0, 110.0, 123.0], "unit": "score", "name": "imaging-darkroom", "value": 109.5}, {"lowerIsBetter": true, "replicates": [90.0, 94.0, 91.0, 92.0, 92.0, 91.0, 93.0, 90.0, 92.0, 100.0], "unit": "score", "name": "imaging-desaturate", "value": 92.5}, {"lowerIsBetter": true, "replicates": [53.0, 49.0, 77.0, 44.0, 47.0, 56.0, 74.0, 91.0, 91.0, 85.0], "unit": "score", "name": "json-parse-financial", "value": 66.7}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 58.0, 95.0, 109.0, 105.0, 92.0, 67.0, 81.0, 88.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 82.9}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 97.0, 86.0, 86.0, 85.0, 103.0, 112.0, 82.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.0}, {"lowerIsBetter": true, "replicates": [138.0, 147.0, 146.0, 123.0, 135.0, 140.0, 144.0, 151.0, 115.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 137.2}, {"lowerIsBetter": true, "replicates": [131.0, 141.0, 144.0, 144.0, 142.0, 134.0, 136.0, 179.0, 183.0, 174.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.8}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 69.0, 66.0, 75.0, 56.0, 61.0, 101.0, 95.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.6}], "name": "kraken", "value": 1561.4}]} 05:51:08 INFO - Return code: 0 05:51:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:51:08 ERROR - # TBPL SUCCESS # 05:51:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:51:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:51:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:51:08 INFO - 2016-04-04 05:51:08.145 screenresolution[1677:10580] starting screenresolution argv=screenresolution get 05:51:08 INFO - 2016-04-04 05:51:08.147 screenresolution[1677:10580] Display 0: 1600x1200x32@60 05:51:08 INFO - 2016-04-04 05:51:08.153 screenresolution[1678:10583] starting screenresolution argv=screenresolution list 05:51:08 INFO - Available Modes on Display 0 05:51:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:51:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:51:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:51:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:51:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:51:08 INFO - Intel Iris: 05:51:08 INFO - Chipset Model: Intel Iris 05:51:08 INFO - Type: GPU 05:51:08 INFO - Bus: Built-In 05:51:08 INFO - VRAM (Dynamic, Max): 1536 MB 05:51:08 INFO - Vendor: Intel (0x8086) 05:51:08 INFO - Device ID: 0x0a2e 05:51:08 INFO - Revision ID: 0x0009 05:51:08 INFO - Displays: 05:51:08 INFO - Display: 05:51:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:51:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:51:08 INFO - Display Serial Number: 1600x1200 60 05:51:08 INFO - Main Display: Yes 05:51:08 INFO - Mirror: Off 05:51:08 INFO - Online: Yes 05:51:08 INFO - Rotation: Supported 05:51:08 INFO - Return code: 0 05:51:08 INFO - Running post-action listener: _resource_record_post_action 05:51:08 INFO - Running post-run listener: _resource_record_post_run 05:51:09 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 37598720; Write bytes: 706951168; Read time: 397; Write time: 1984 05:51:09 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399053312; Write bytes: 394246144; Read time: 29983; Write time: 814 05:51:09 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 35767808; Write bytes: 301543424; Read time: 372; Write time: 1140 05:51:09 INFO - Running post-run listener: _upload_blobber_files 05:51:09 INFO - Blob upload gear active. 05:51:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:51:09 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 05:51:09 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'] 05:51:09 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 05:51:09 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:51:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:51:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:10 INFO - (blobuploader) - INFO - Done attempting. 05:51:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:51:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:51:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:11 INFO - (blobuploader) - INFO - Done attempting. 05:51:11 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:11 INFO - Return code: 0 05:51:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:51:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/348757a5e6279bac56d2e6c864636a16c55972234a69a201377ee44961acfdf5eb4151859d9ddd8b42f328409242c3ea6e5cc2470c40ff9b51c78e79b5ab9af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce762fdbae5b62339c68722dbd9c6c68c57e4c0f3f89519744a128a26250af7d5af32fe426a31f6746f02ced743ca4fff842bae0264b4547b881c406b2de3875"} 05:51:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:51:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:51:11 INFO - Contents: 05:51:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/348757a5e6279bac56d2e6c864636a16c55972234a69a201377ee44961acfdf5eb4151859d9ddd8b42f328409242c3ea6e5cc2470c40ff9b51c78e79b5ab9af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce762fdbae5b62339c68722dbd9c6c68c57e4c0f3f89519744a128a26250af7d5af32fe426a31f6746f02ced743ca4fff842bae0264b4547b881c406b2de3875"} 05:51:11 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:11 INFO - Copying logs to upload dir... 05:51:11 INFO - mkdir: /builds/slave/test/build/upload/logs 05:51:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.618389 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-04 05:51:11.537807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-04 05:51:11.541246) ========= 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.7LgIShoPLf/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.6wY9VoSV0G/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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/348757a5e6279bac56d2e6c864636a16c55972234a69a201377ee44961acfdf5eb4151859d9ddd8b42f328409242c3ea6e5cc2470c40ff9b51c78e79b5ab9af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce762fdbae5b62339c68722dbd9c6c68c57e4c0f3f89519744a128a26250af7d5af32fe426a31f6746f02ced743ca4fff842bae0264b4547b881c406b2de3875"} build_url:https://queue.taskcluster.net/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/U2sks4FLSs-eJaORFYC5pw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/348757a5e6279bac56d2e6c864636a16c55972234a69a201377ee44961acfdf5eb4151859d9ddd8b42f328409242c3ea6e5cc2470c40ff9b51c78e79b5ab9af5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce762fdbae5b62339c68722dbd9c6c68c57e4c0f3f89519744a128a26250af7d5af32fe426a31f6746f02ced743ca4fff842bae0264b4547b881c406b2de3875"}' ========= master_lag: 3.40 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-04 05:51:14.948514) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 05:51:14.948863) ========= 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.7LgIShoPLf/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.6wY9VoSV0G/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005044 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 05:51:14.971248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 05:51:14.971522) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 05:51:14.971859) ========= ========= Total master_lag: 8.46 =========