builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0181 starttime: 1460550727.94 results: success (0) buildid: 20160413033554 builduid: c37f8d43bd87400aa2f4d55833e00664 revision: f6c99ce0e2a7cfe63ca21f534529f4f5b8ff6b56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:07.942213) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:07.942711) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:07.943051) ========= 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.Bfv7dam020/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.kxcLEeGgL3/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.005743 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:07.972539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:07.972866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:07.988481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:07.988832) ========= 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.Bfv7dam020/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.kxcLEeGgL3/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.005272 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:08.040228) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:08.040551) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:08.040923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:08.041238) ========= 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.Bfv7dam020/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.kxcLEeGgL3/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-13 05:32:08-- 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% 8.22M=0.001s 2016-04-13 05:32:08 (8.22 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176640 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:08.237616) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:08.237924) ========= 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.Bfv7dam020/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.kxcLEeGgL3/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.020580 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:08.289809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-13 05:32:08.293013) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f6c99ce0e2a7cfe63ca21f534529f4f5b8ff6b56 --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 f6c99ce0e2a7cfe63ca21f534529f4f5b8ff6b56 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Bfv7dam020/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.kxcLEeGgL3/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-13 05:32:08,370 truncating revision to first 12 chars 2016-04-13 05:32:08,370 Setting DEBUG logging. 2016-04-13 05:32:08,370 attempt 1/10 2016-04-13 05:32:08,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f6c99ce0e2a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 05:32:09,486 unpacking tar archive at: fx-team-f6c99ce0e2a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.367583 ========= master_lag: 0.86 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-13 05:32:10.519260) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:10.519618) ========= echo f6c99ce0e2a7cfe63ca21f534529f4f5b8ff6b56 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f6c99ce0e2a7cfe63ca21f534529f4f5b8ff6b56'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Bfv7dam020/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.kxcLEeGgL3/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 f6c99ce0e2a7cfe63ca21f534529f4f5b8ff6b56 program finished with exit code 0 elapsedTime=0.005412 script_repo_revision: 'f6c99ce0e2a7cfe63ca21f534529f4f5b8ff6b56' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:10.548110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:10.548440) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 05:32:10.562427) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-13 05:32:10.562784) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.Bfv7dam020/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.kxcLEeGgL3/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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:32:10 INFO - MultiFileLogger online at 20160413 05:32:10 in /builds/slave/test 05:32:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:32:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:10 INFO - {'append_to_log': False, 05:32:10 INFO - 'base_work_dir': '/builds/slave/test', 05:32:10 INFO - 'blob_upload_branch': 'Fx-Team', 05:32:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:10 INFO - 'branch': 'Fx-Team', 05:32:10 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:10 INFO - 'config_files': ('talos/mac_config.py',), 05:32:10 INFO - 'default_actions': ('clobber', 05:32:10 INFO - 'read-buildbot-config', 05:32:10 INFO - 'download-and-extract', 05:32:10 INFO - 'populate-webroot', 05:32:10 INFO - 'create-virtualenv', 05:32:10 INFO - 'install', 05:32:10 INFO - 'run-tests'), 05:32:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:10 INFO - 'download_minidump_stackwalk': True, 05:32:10 INFO - 'download_symbols': 'ondemand', 05:32:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:10 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:10 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:10 INFO - 'installer_path': 'installer.exe', 05:32:10 INFO - 'log_level': 'info', 05:32:10 INFO - 'log_name': 'talos', 05:32:10 INFO - 'log_to_console': True, 05:32:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:32:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:32:10 INFO - 'opt_config_files': (), 05:32:10 INFO - 'pip_index': False, 05:32:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:10 INFO - 'cmd': ('bash', 05:32:10 INFO - '-c', 05:32:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:10 INFO - 'enabled': True, 05:32:10 INFO - 'halt_on_failure': False, 05:32:10 INFO - 'name': 'check_screen_resolution'},), 05:32:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:10 INFO - 'cmd': ('bash', 05:32:10 INFO - '-c', 05:32:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:10 INFO - 'enabled': True, 05:32:10 INFO - 'halt_on_failure': False, 05:32:10 INFO - 'name': 'check_screen_resolution'},), 05:32:10 INFO - 'run_cmd_checks_enabled': True, 05:32:10 INFO - 'sps_profile': False, 05:32:10 INFO - 'sps_profile_interval': 0, 05:32:10 INFO - 'suite': 'dromaeojs', 05:32:10 INFO - 'system_bits': '32', 05:32:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:10 INFO - 'title': 't-yosemite-r7-0181', 05:32:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:10 INFO - 'use_talos_json': True, 05:32:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:10 INFO - 'work_dir': 'build'} 05:32:10 INFO - ##### 05:32:10 INFO - ##### Running clobber step. 05:32:10 INFO - ##### 05:32:10 INFO - Running pre-action listener: _resource_record_pre_action 05:32:10 INFO - Running main action method: clobber 05:32:10 INFO - rmtree: /builds/slave/test/build 05:32:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:11 INFO - Running post-action listener: _resource_record_post_action 05:32:11 INFO - ##### 05:32:11 INFO - ##### Running read-buildbot-config step. 05:32:11 INFO - ##### 05:32:11 INFO - Running pre-action listener: _resource_record_pre_action 05:32:11 INFO - Running main action method: read_buildbot_config 05:32:11 INFO - Using buildbot properties: 05:32:11 INFO - { 05:32:11 INFO - "project": "", 05:32:11 INFO - "product": "firefox", 05:32:11 INFO - "script_repo_revision": "production", 05:32:11 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:32:11 INFO - "repository": "", 05:32:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:32:11 INFO - "buildid": "20160413033554", 05:32:11 INFO - "pgo_build": "False", 05:32:11 INFO - "basedir": "/builds/slave/test", 05:32:11 INFO - "buildnumber": 712, 05:32:11 INFO - "slavename": "t-yosemite-r7-0181", 05:32:11 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:32:11 INFO - "platform": "yosemite_r7", 05:32:11 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:32:11 INFO - "branch": "fx-team", 05:32:11 INFO - "repo_path": "integration/fx-team", 05:32:11 INFO - "revision": "f6c99ce0e2a7cfe63ca21f534529f4f5b8ff6b56", 05:32:11 INFO - "stage_platform": "macosx64", 05:32:11 INFO - "builduid": "c37f8d43bd87400aa2f4d55833e00664", 05:32:11 INFO - "slavebuilddir": "test" 05:32:11 INFO - } 05:32:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:32:11 INFO - Running post-action listener: _resource_record_post_action 05:32:11 INFO - ##### 05:32:11 INFO - ##### Running download-and-extract step. 05:32:11 INFO - ##### 05:32:11 INFO - Running pre-action listener: _resource_record_pre_action 05:32:11 INFO - Running main action method: download_and_extract 05:32:11 INFO - mkdir: /builds/slave/test/build/tests 05:32:11 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:32:11 INFO - https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:32:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:32:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:32:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/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:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/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:32:13 INFO - Downloaded 1199 bytes. 05:32:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:32:13 INFO - Using the following test package requirements: 05:32:13 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:32:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:32:13 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:32:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:32:13 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:32:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:32:13 INFO - u'jsshell-mac.zip'], 05:32:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:32:13 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:32:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:32:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:32:13 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:32:13 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:32:13 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:32:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:32:13 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:32:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:32:13 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:32:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:13 INFO - https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:32:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:32:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:32:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/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:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/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:32:14 INFO - Downloaded 18027435 bytes. 05:32:14 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:32:14 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:32:17 INFO - Return code: 0 05:32:17 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:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:17 INFO - https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:32:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:32:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:32:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/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:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/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:32:19 INFO - Downloaded 18027435 bytes. 05:32:19 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:32:19 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:32:23 INFO - Return code: 0 05:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:23 INFO - https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:32:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:32:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:32:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/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:32:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/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:32:24 INFO - Downloaded 10841076 bytes. 05:32:24 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:32:24 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:32:24 INFO - Return code: 0 05:32:24 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:32:24 INFO - https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:32:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:32:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:32:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:32:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmyeyDlYTgi7-GMPf0-bzA/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:32:27 INFO - Downloaded 109320712 bytes. 05:32:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:32:27 INFO - mkdir: /builds/slave/test/properties 05:32:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:27 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:27 INFO - Contents: 05:32:27 INFO - build_url:https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:32:28 INFO - Running post-action listener: _resource_record_post_action 05:32:28 INFO - Running post-action listener: set_extra_try_arguments 05:32:28 INFO - ##### 05:32:28 INFO - ##### Running populate-webroot step. 05:32:28 INFO - ##### 05:32:28 INFO - Running pre-action listener: _resource_record_pre_action 05:32:28 INFO - Running main action method: populate_webroot 05:32:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:28 INFO - '--tppagecycles', 05:32:28 INFO - '7'], 05:32:28 INFO - 'tests': ['tsvgm']}}, 05:32:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:28 INFO - 'talos_options': ['--disable-e10s'], 05:32:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:28 INFO - 'talos_options': ['--disable-e10s'], 05:32:28 INFO - 'tests': ['damp', 'tps']}, 05:32:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:28 INFO - 'tests': ['damp', 'tps']}, 05:32:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:28 INFO - 'tests': ['dromaeo_dom']}, 05:32:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:28 INFO - 'tests': ['a11yr', 05:32:28 INFO - 'ts_paint', 05:32:28 INFO - 'tpaint', 05:32:28 INFO - 'sessionrestore', 05:32:28 INFO - 'sessionrestore_no_auto_restore', 05:32:28 INFO - 'tabpaint']}, 05:32:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:28 INFO - 'ts_paint', 05:32:28 INFO - 'tpaint', 05:32:28 INFO - 'sessionrestore', 05:32:28 INFO - 'sessionrestore_no_auto_restore', 05:32:28 INFO - 'tabpaint']}, 05:32:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:28 INFO - 'ts_paint', 05:32:28 INFO - 'tpaint', 05:32:28 INFO - 'sessionrestore', 05:32:28 INFO - 'sessionrestore_no_auto_restore', 05:32:28 INFO - 'tabpaint']}, 05:32:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:28 INFO - 'ts_paint', 05:32:28 INFO - 'tpaint', 05:32:28 INFO - 'sessionrestore', 05:32:28 INFO - 'sessionrestore_no_auto_restore', 05:32:28 INFO - 'tabpaint']}, 05:32:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:28 INFO - 'tests': ['a11yr', 05:32:28 INFO - 'ts_paint', 05:32:28 INFO - 'tpaint', 05:32:28 INFO - 'sessionrestore', 05:32:28 INFO - 'sessionrestore_no_auto_restore', 05:32:28 INFO - 'tabpaint']}, 05:32:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:28 INFO - 'tests': ['a11yr', 05:32:28 INFO - 'ts_paint', 05:32:28 INFO - 'tpaint', 05:32:28 INFO - 'sessionrestore', 05:32:28 INFO - 'sessionrestore_no_auto_restore', 05:32:28 INFO - 'tabpaint']}, 05:32:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:28 INFO - 'tests': ['tsvgx', 05:32:28 INFO - 'tsvgr_opacity', 05:32:28 INFO - 'tart', 05:32:28 INFO - 'tscrollx', 05:32:28 INFO - 'cart']}, 05:32:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:28 INFO - 'tsvgr_opacity', 05:32:28 INFO - 'tart', 05:32:28 INFO - 'tscrollx', 05:32:28 INFO - 'cart']}, 05:32:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:28 INFO - 'talos_options': ['--disable-e10s'], 05:32:28 INFO - 'tests': ['tp5o']}, 05:32:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:28 INFO - 'tests': ['tp5o']}, 05:32:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:28 INFO - 'talos_options': ['--disable-e10s', 05:32:28 INFO - '--xperf_path', 05:32:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:28 INFO - 'tests': ['tp5n']}, 05:32:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:28 INFO - 'talos_options': ['--xperf_path', 05:32:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:28 INFO - 'tests': ['tp5n']}}, 05:32:28 INFO - 'talos.zip': {'path': '', 05:32:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:28 INFO - Running post-action listener: _resource_record_post_action 05:32:28 INFO - ##### 05:32:28 INFO - ##### Running create-virtualenv step. 05:32:28 INFO - ##### 05:32:28 INFO - Running pre-action listener: _resource_record_pre_action 05:32:28 INFO - Running main action method: create_virtualenv 05:32:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32: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:32:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:28 INFO - Using real prefix '/tools/python27' 05:32:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:32 INFO - Installing pip.................done. 05:32:32 INFO - Return code: 0 05:32:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32: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:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2590e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a5fe00>, '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 0x100888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5ab20>, '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.Bfv7dam020/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.kxcLEeGgL3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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:32: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', 'pip>=1.5'] in /builds/slave/test/build 05:32: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 pip>=1.5 05:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bfv7dam020/Render', 05:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:32 INFO - 'HOME': '/Users/cltbld', 05:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:32 INFO - 'LOGNAME': 'cltbld', 05:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:32 INFO - 'MOZ_NO_REMOTE': '1', 05:32:32 INFO - 'NO_EM_RESTART': '1', 05:32:32 INFO - 'PAGER': '/bin/cat', 05:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:32 INFO - 'PWD': '/builds/slave/test', 05:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:32 INFO - 'SHELL': '/bin/bash', 05:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kxcLEeGgL3/Listeners', 05:32:32 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 05:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:32 INFO - 'USER': 'cltbld', 05:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:32 INFO - 'XPC_FLAGS': '0x0', 05:32:32 INFO - 'XPC_SERVICE_NAME': '0', 05:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32: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:32:32 INFO - Cleaning up... 05:32:32 INFO - Return code: 0 05:32:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:32: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:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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 0x100bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2590e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a5fe00>, '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 0x100888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5ab20>, '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.Bfv7dam020/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.kxcLEeGgL3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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:32: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:32: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:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bfv7dam020/Render', 05:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:32 INFO - 'HOME': '/Users/cltbld', 05:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:32 INFO - 'LOGNAME': 'cltbld', 05:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:32 INFO - 'MOZ_NO_REMOTE': '1', 05:32:32 INFO - 'NO_EM_RESTART': '1', 05:32:32 INFO - 'PAGER': '/bin/cat', 05:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:32 INFO - 'PWD': '/builds/slave/test', 05:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:32 INFO - 'SHELL': '/bin/bash', 05:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kxcLEeGgL3/Listeners', 05:32:32 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 05:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:32 INFO - 'USER': 'cltbld', 05:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:32 INFO - 'XPC_FLAGS': '0x0', 05:32:32 INFO - 'XPC_SERVICE_NAME': '0', 05:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:33 INFO - Downloading/unpacking psutil>=0.7.1 05:32:33 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:32:33 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:32:33 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:32:33 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:32:33 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:32:33 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:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:36 INFO - Installing collected packages: psutil 05:32:36 INFO - Running setup.py install for psutil 05:32:36 INFO - building 'psutil._psutil_osx' extension 05:32:36 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:32:36 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:32:36 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:32:36 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:32:36 INFO - building 'psutil._psutil_posix' extension 05:32:36 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:32:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:36 INFO - ^ 05:32:36 INFO - 1 warning generated. 05:32:36 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:32:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:36 INFO - Successfully installed psutil 05:32:36 INFO - Cleaning up... 05:32:36 INFO - Return code: 0 05:32:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:32: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:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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 0x100bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2590e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a5fe00>, '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 0x100888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5ab20>, '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.Bfv7dam020/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.kxcLEeGgL3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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:32: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:32: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:32:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bfv7dam020/Render', 05:32:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:36 INFO - 'HOME': '/Users/cltbld', 05:32:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:36 INFO - 'LOGNAME': 'cltbld', 05:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:36 INFO - 'MOZ_NO_REMOTE': '1', 05:32:36 INFO - 'NO_EM_RESTART': '1', 05:32:36 INFO - 'PAGER': '/bin/cat', 05:32:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:36 INFO - 'PWD': '/builds/slave/test', 05:32:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:36 INFO - 'SHELL': '/bin/bash', 05:32:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kxcLEeGgL3/Listeners', 05:32:36 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 05:32:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:36 INFO - 'USER': 'cltbld', 05:32:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:36 INFO - 'XPC_FLAGS': '0x0', 05:32:36 INFO - 'XPC_SERVICE_NAME': '0', 05:32:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:39 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:32:39 INFO - Installing collected packages: mozsystemmonitor 05:32:39 INFO - Running setup.py install for mozsystemmonitor 05:32:39 INFO - Successfully installed mozsystemmonitor 05:32:39 INFO - Cleaning up... 05:32:39 INFO - Return code: 0 05:32:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:39 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 0x100bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2590e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a5fe00>, '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 0x100888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5ab20>, '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.Bfv7dam020/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.kxcLEeGgL3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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:32:39 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:32:39 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:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bfv7dam020/Render', 05:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:39 INFO - 'HOME': '/Users/cltbld', 05:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:39 INFO - 'LOGNAME': 'cltbld', 05:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:39 INFO - 'MOZ_NO_REMOTE': '1', 05:32:39 INFO - 'NO_EM_RESTART': '1', 05:32:39 INFO - 'PAGER': '/bin/cat', 05:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:39 INFO - 'PWD': '/builds/slave/test', 05:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:39 INFO - 'SHELL': '/bin/bash', 05:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kxcLEeGgL3/Listeners', 05:32:39 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 05:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:39 INFO - 'USER': 'cltbld', 05:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:39 INFO - 'XPC_FLAGS': '0x0', 05:32:39 INFO - 'XPC_SERVICE_NAME': '0', 05:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:40 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:42 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32: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:32: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:32: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:32: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:32: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:32: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:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:43 INFO - Downloading docopt-0.6.1.tar.gz 05:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:43 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:43 INFO - Running setup.py install for blobuploader 05:32:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:43 INFO - Running setup.py install for requests 05:32:44 INFO - Running setup.py install for docopt 05:32:44 INFO - Successfully installed blobuploader requests docopt 05:32:44 INFO - Cleaning up... 05:32:44 INFO - Return code: 0 05:32:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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 0x100bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2590e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a5fe00>, '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 0x100888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5ab20>, '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.Bfv7dam020/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.kxcLEeGgL3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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:32: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:32: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:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bfv7dam020/Render', 05:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:44 INFO - 'HOME': '/Users/cltbld', 05:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:44 INFO - 'LOGNAME': 'cltbld', 05:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:44 INFO - 'MOZ_NO_REMOTE': '1', 05:32:44 INFO - 'NO_EM_RESTART': '1', 05:32:44 INFO - 'PAGER': '/bin/cat', 05:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:44 INFO - 'PWD': '/builds/slave/test', 05:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:44 INFO - 'SHELL': '/bin/bash', 05:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kxcLEeGgL3/Listeners', 05:32:44 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 05:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:44 INFO - 'USER': 'cltbld', 05:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:44 INFO - 'XPC_FLAGS': '0x0', 05:32:44 INFO - 'XPC_SERVICE_NAME': '0', 05:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-drf2LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-KEriB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-c6B3jF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-x7SaVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-DIDp4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-mNLvCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-G9CT2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ja2B6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-FUN0hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-nrKP3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-RKEiAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-d7OpOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-vMk5Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-9gdFiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-2OuWCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-yzudrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:46 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-owZm18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:46 INFO - Running setup.py install for manifestparser 05:32:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:46 INFO - Running setup.py install for mozcrash 05:32:47 INFO - Running setup.py install for mozdebug 05:32:47 INFO - Running setup.py install for mozdevice 05:32:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Running setup.py install for mozfile 05:32:47 INFO - Running setup.py install for mozhttpd 05:32:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Running setup.py install for mozinfo 05:32:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Running setup.py install for mozInstall 05:32:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:47 INFO - Running setup.py install for mozleak 05:32:48 INFO - Running setup.py install for mozlog 05:32:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Running setup.py install for moznetwork 05:32:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Running setup.py install for mozprocess 05:32:48 INFO - Running setup.py install for mozprofile 05:32:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Running setup.py install for mozrunner 05:32:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:48 INFO - Running setup.py install for mozscreenshot 05:32:48 INFO - Running setup.py install for moztest 05:32:49 INFO - Running setup.py install for mozversion 05:32:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:49 INFO - Cleaning up... 05:32:49 INFO - Return code: 0 05:32:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:49 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:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:49 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:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:49 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 0x100bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2590e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a5fe00>, '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 0x100888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5ab20>, '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.Bfv7dam020/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.kxcLEeGgL3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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:32:49 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:32:49 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:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bfv7dam020/Render', 05:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:49 INFO - 'HOME': '/Users/cltbld', 05:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:49 INFO - 'LOGNAME': 'cltbld', 05:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:49 INFO - 'MOZ_NO_REMOTE': '1', 05:32:49 INFO - 'NO_EM_RESTART': '1', 05:32:49 INFO - 'PAGER': '/bin/cat', 05:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:49 INFO - 'PWD': '/builds/slave/test', 05:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:49 INFO - 'SHELL': '/bin/bash', 05:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kxcLEeGgL3/Listeners', 05:32:49 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 05:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:49 INFO - 'USER': 'cltbld', 05:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:49 INFO - 'XPC_FLAGS': '0x0', 05:32:49 INFO - 'XPC_SERVICE_NAME': '0', 05:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-wmHPey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32: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:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Rcn2uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32: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:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-g5zSdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32: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:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:49 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-_ELpTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-6BZAZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-_7pPZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-b11SYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-cvFNfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-phh6e0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:50 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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-LFE4v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32: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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-J8wXn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32: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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-K9tGor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32: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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-B7aEgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32: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:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:50 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-tqs2xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:51 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:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-frjb88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:51 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:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-QxFbxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:51 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:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:51 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-OuIjhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:51 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:32:51 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:32:51 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:32:51 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:32:51 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:32:51 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:32:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:51 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:32:51 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:32:51 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:32:51 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:32:51 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:32:51 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:32:53 INFO - Downloading blessings-1.6.tar.gz 05:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:53 INFO - Installing collected packages: blessings 05:32:53 INFO - Running setup.py install for blessings 05:32:54 INFO - Successfully installed blessings 05:32:54 INFO - Cleaning up... 05:32:54 INFO - Return code: 0 05:32:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:54 INFO - Reading from file tmpfile_stdout 05:32:54 INFO - Current package versions: 05:32:54 INFO - blessings == 1.6 05:32:54 INFO - blobuploader == 1.2.4 05:32:54 INFO - docopt == 0.6.1 05:32:54 INFO - manifestparser == 1.1 05:32:54 INFO - mozInstall == 1.12 05:32:54 INFO - mozcrash == 0.17 05:32:54 INFO - mozdebug == 0.1 05:32:54 INFO - mozdevice == 0.48 05:32:54 INFO - mozfile == 1.2 05:32:54 INFO - mozhttpd == 0.7 05:32:54 INFO - mozinfo == 0.9 05:32:54 INFO - mozleak == 0.1 05:32:54 INFO - mozlog == 3.1 05:32:54 INFO - moznetwork == 0.27 05:32:54 INFO - mozprocess == 0.22 05:32:54 INFO - mozprofile == 0.28 05:32:54 INFO - mozrunner == 6.11 05:32:54 INFO - mozscreenshot == 0.1 05:32:54 INFO - mozsystemmonitor == 0.0 05:32:54 INFO - moztest == 0.7 05:32:54 INFO - mozversion == 1.4 05:32:54 INFO - psutil == 3.1.1 05:32:54 INFO - requests == 1.2.3 05:32:54 INFO - wsgiref == 0.1.2 05:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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 0x100bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2590e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a5fe00>, '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 0x100888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5ab20>, '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.Bfv7dam020/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.kxcLEeGgL3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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:32: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:32: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:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bfv7dam020/Render', 05:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:54 INFO - 'HOME': '/Users/cltbld', 05:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:54 INFO - 'LOGNAME': 'cltbld', 05:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:54 INFO - 'MOZ_NO_REMOTE': '1', 05:32:54 INFO - 'NO_EM_RESTART': '1', 05:32:54 INFO - 'PAGER': '/bin/cat', 05:32:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:54 INFO - 'PWD': '/builds/slave/test', 05:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:54 INFO - 'SHELL': '/bin/bash', 05:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kxcLEeGgL3/Listeners', 05:32:54 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 05:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:54 INFO - 'USER': 'cltbld', 05:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:54 INFO - 'XPC_FLAGS': '0x0', 05:32:54 INFO - 'XPC_SERVICE_NAME': '0', 05:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32: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:32: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:32: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:32: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:32: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:32: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:32: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:32: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:32: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:32: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:32: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:32:54 INFO - Cleaning up... 05:32:54 INFO - Return code: 0 05:32:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32: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:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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 0x100bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2590e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a5fe00>, '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 0x100888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5ab20>, '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.Bfv7dam020/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.kxcLEeGgL3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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:32: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:32: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:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bfv7dam020/Render', 05:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:54 INFO - 'HOME': '/Users/cltbld', 05:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:54 INFO - 'LOGNAME': 'cltbld', 05:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:54 INFO - 'MOZ_NO_REMOTE': '1', 05:32:54 INFO - 'NO_EM_RESTART': '1', 05:32:54 INFO - 'PAGER': '/bin/cat', 05:32:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:54 INFO - 'PWD': '/builds/slave/test', 05:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:54 INFO - 'SHELL': '/bin/bash', 05:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kxcLEeGgL3/Listeners', 05:32:54 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 05:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:54 INFO - 'USER': 'cltbld', 05:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:54 INFO - 'XPC_FLAGS': '0x0', 05:32:54 INFO - 'XPC_SERVICE_NAME': '0', 05:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:54 INFO - Downloading/unpacking jsonschema 05:32: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:32: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:32: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:32: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:32: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:32: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:32:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:57 INFO - Downloading/unpacking functools32 (from jsonschema) 05:32: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:32: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:32: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:32: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:32: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:32: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:32:57 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:57 INFO - warning: no files found matching '*.txt' 05:32:57 INFO - no previously-included directories found matching 'build' 05:32:57 INFO - no previously-included directories found matching 'dist' 05:32:57 INFO - no previously-included directories found matching '.git*' 05:32:57 INFO - Installing collected packages: jsonschema, functools32 05:32:57 INFO - Running setup.py install for functools32 05:32:57 INFO - warning: no files found matching '*.txt' 05:32:57 INFO - no previously-included directories found matching 'build' 05:32:57 INFO - no previously-included directories found matching 'dist' 05:32:57 INFO - no previously-included directories found matching '.git*' 05:32:57 INFO - Successfully installed jsonschema functools32 05:32:57 INFO - Cleaning up... 05:32:58 INFO - Return code: 0 05:32:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:58 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 0x100bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100bd0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac2590e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a5fe00>, '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 0x100888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5ab20>, '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.Bfv7dam020/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.kxcLEeGgL3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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:32:58 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:32:58 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:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bfv7dam020/Render', 05:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:58 INFO - 'HOME': '/Users/cltbld', 05:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:58 INFO - 'LOGNAME': 'cltbld', 05:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:58 INFO - 'MOZ_NO_REMOTE': '1', 05:32:58 INFO - 'NO_EM_RESTART': '1', 05:32:58 INFO - 'PAGER': '/bin/cat', 05:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:58 INFO - 'PWD': '/builds/slave/test', 05:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:58 INFO - 'SHELL': '/bin/bash', 05:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kxcLEeGgL3/Listeners', 05:32:58 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 05:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:58 INFO - 'USER': 'cltbld', 05:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:58 INFO - 'XPC_FLAGS': '0x0', 05:32:58 INFO - 'XPC_SERVICE_NAME': '0', 05:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:58 INFO - Downloading/unpacking flake8 05:32: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:32: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:32: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:32: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:32: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:32: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:33:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:33:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:33: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:33: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:33: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:33: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:33: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:33: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:33:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:33:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:33: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:33: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:33: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:33: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:33: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:33: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:33:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:33: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:33: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:33: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:33: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:33: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:33: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:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:33:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:33:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:33:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:33:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:33:01 INFO - no previously-included directories found matching 'docs/_build' 05:33:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:33:02 INFO - Running setup.py install for pep8 05:33:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:33:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:33:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:33:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:33:02 INFO - no previously-included directories found matching 'docs/_build' 05:33:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:33:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:33:02 INFO - Cleaning up... 05:33:02 INFO - Return code: 0 05:33:02 INFO - Running post-action listener: _resource_record_post_action 05:33:02 INFO - Running post-action listener: _start_resource_monitoring 05:33:02 INFO - Starting resource monitoring. 05:33:02 INFO - ##### 05:33:02 INFO - ##### Running install step. 05:33:02 INFO - ##### 05:33:02 INFO - Running pre-action listener: _resource_record_pre_action 05:33:02 INFO - Running main action method: install 05:33:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:02 INFO - Reading from file tmpfile_stdout 05:33:02 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:02 INFO - Reading from file tmpfile_stdout 05:33:02 INFO - Output received: 05:33:02 INFO - Usage: mozinstall [options] installer 05:33:02 INFO - Options: 05:33:02 INFO - -h, --help show this help message and exit 05:33:02 INFO - -d DEST, --destination=DEST 05:33:02 INFO - Directory to install application into. [default: 05:33:02 INFO - "/builds/slave/test"] 05:33:02 INFO - --app=APP Application being installed. [default: firefox] 05:33:02 INFO - mkdir: /builds/slave/test/build/application 05:33: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:33: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:33:36 INFO - Reading from file tmpfile_stdout 05:33:36 INFO - Output received: 05:33:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:33:36 INFO - Running post-action listener: _resource_record_post_action 05:33:36 INFO - ##### 05:33:36 INFO - ##### Running run-tests step. 05:33:36 INFO - ##### 05:33:36 INFO - Running pre-action listener: _resource_record_pre_action 05:33:36 INFO - Running main action method: run_tests 05:33:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:36 INFO - 2016-04-13 05:33:36.166 screenresolution[2476:19532] starting screenresolution argv=screenresolution get 05:33:36 INFO - 2016-04-13 05:33:36.169 screenresolution[2476:19532] Display 0: 1600x1200x32@60 05:33:36 INFO - 2016-04-13 05:33:36.175 screenresolution[2477:19534] starting screenresolution argv=screenresolution list 05:33:36 INFO - Available Modes on Display 0 05:33:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:36 INFO - Intel Iris: 05:33:36 INFO - Chipset Model: Intel Iris 05:33:36 INFO - Type: GPU 05:33:36 INFO - Bus: Built-In 05:33:36 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:36 INFO - Vendor: Intel (0x8086) 05:33:36 INFO - Device ID: 0x0a2e 05:33:36 INFO - Revision ID: 0x0009 05:33:36 INFO - Displays: 05:33:36 INFO - Display: 05:33:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:36 INFO - Display Serial Number: 1600x1200 60 05:33:36 INFO - Main Display: Yes 05:33:36 INFO - Mirror: Off 05:33:36 INFO - Online: Yes 05:33:36 INFO - Rotation: Supported 05:33:36 INFO - Return code: 0 05:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:36 INFO - Python 2.7.3 05:33:36 INFO - Return code: 0 05:33:36 INFO - grabbing minidump binary from tooltool 05:33: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:33: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 0x100a5fe00>, '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 0x100888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a5ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33: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:33: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:33:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:36 INFO - Return code: 0 05:33:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:33:37 INFO - Return code: 0 05:33: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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:33: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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0181 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bfv7dam020/Render', 05:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:37 INFO - 'HOME': '/Users/cltbld', 05:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:37 INFO - 'LOGNAME': 'cltbld', 05:33:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:37 INFO - 'MOZ_NO_REMOTE': '1', 05:33:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:37 INFO - 'NO_EM_RESTART': '1', 05:33:37 INFO - 'PAGER': '/bin/cat', 05:33: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:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:37 INFO - 'PWD': '/builds/slave/test', 05:33:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:37 INFO - 'SHELL': '/bin/bash', 05:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kxcLEeGgL3/Listeners', 05:33:37 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 05:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:37 INFO - 'USER': 'cltbld', 05:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:37 INFO - 'XPC_FLAGS': '0x0', 05:33:37 INFO - 'XPC_SERVICE_NAME': '0', 05:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33: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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:33:37 INFO - mozversion application_buildid: 20160413033554 05:33:37 INFO - mozversion application_changeset: f6c99ce0e2a7cfe63ca21f534529f4f5b8ff6b56 05:33:37 INFO - mozversion application_display_name: Nightly 05:33:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:37 INFO - mozversion application_name: Firefox 05:33:37 INFO - mozversion application_remotingname: firefox 05:33:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:33:37 INFO - mozversion application_vendor: Mozilla 05:33:37 INFO - mozversion application_version: 48.0a1 05:33:37 INFO - mozversion platform_buildid: 20160413033554 05:33:37 INFO - mozversion platform_changeset: f6c99ce0e2a7cfe63ca21f534529f4f5b8ff6b56 05:33:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:33:37 INFO - mozversion platform_version: 48.0a1 05:33:37 INFO - using testdate: 1460550817 05:33:37 INFO - actual date: 1460550817 05:33:37 INFO - starting webserver on 'localhost:51521' 05:33:37 INFO - SUITE-START | Running 2 tests 05:33:37 INFO - TEST-START | dromaeo_css 05:33:37 INFO - operating with platform_type : mac_ 05:33:37 INFO - Initialising browser for dromaeo_css test... 05:33:37 INFO - TEST-INFO | started process 2495 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpxDhBTy/profile http://localhost:51521/getInfo.html) 05:33:40 INFO - PROCESS | 2495 | __metrics Screen width/height:1600/1200 05:33:40 INFO - PROCESS | 2495 | colorDepth:24 05:33:40 INFO - PROCESS | 2495 | Browser inner width/height: 1024/689 05:33:40 INFO - PROCESS | 2495 | __metrics 05:33:40 INFO - PROCESS | 2495 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:33:40 ERROR - PROCESS | 2495 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:33:40 INFO - TEST-INFO | 2495: exit 0 05:33:40 INFO - Browser initialized. 05:33:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:40 INFO - TEST-INFO | started process 2497 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpxDhBTy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:52 INFO - PROCESS | 2497 | RSS: Main: 237436928 05:33:52 INFO - PROCESS | 2497 | 05:34:44 INFO - PROCESS | 2497 | 1460550884457 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:36:55 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51521/tests/dromaeo/cssquery-ext.html) 05:36:56 INFO - PROCESS | 2497 | RSS: Main: 382820352 05:36:56 INFO - PROCESS | 2497 | 05:39:59 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-ext.html (next: http://localhost:51521/tests/dromaeo/cssquery-jquery.html) 05:40:00 INFO - PROCESS | 2497 | RSS: Main: 378691584 05:40:00 INFO - PROCESS | 2497 | 05:43:02 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51521/tests/dromaeo/cssquery-mootools.html) 05:43:03 INFO - PROCESS | 2497 | RSS: Main: 377950208 05:43:03 INFO - PROCESS | 2497 | 05:46:05 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51521/tests/dromaeo/cssquery-prototype.html) 05:46:05 INFO - PROCESS | 2497 | RSS: Main: 376250368 05:46:05 INFO - PROCESS | 2497 | 05:49:08 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51521/tests/dromaeo/cssquery-yui.html) 05:49:09 INFO - PROCESS | 2497 | RSS: Main: 349421568 05:49:09 INFO - PROCESS | 2497 | 05:52:12 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:51521/tests/dromaeo/cssquery-yui.html (next: http://localhost:51521/tests/dromaeo/cssquery-dojo.html) 05:52:12 INFO - PROCESS | 2497 | RSS: Main: 381636608 05:52:12 INFO - PROCESS | 2497 | 05:52:12 INFO - PROCESS | 2497 | __start_tp_report 05:52:12 INFO - PROCESS | 2497 | _x_x_mozilla_page_load 05:52:12 INFO - PROCESS | 2497 | _x_x_mozilla_page_load_details 05:52:12 INFO - PROCESS | 2497 | |i|pagename|runs| 05:52:12 INFO - PROCESS | 2497 | |0;dojo.html;3375.848086836092;3434.313137372526;3454.6199918009024;3479.112826229311;3495.1961048958738;5562.499375056244;5638.887222255553;5659.575531835108;5661.490465858072;5665.915011274829;5632.690202038886;5772.942270577293;5775.740091695873;5777.393373695754;5850.946829570676;5142.948570514303;5167.121589329804;5170.870728231796;5207.140821764404;5209.661372010826;5109.233614957768;5228.712420816853;5256.211568264772;5280.445553216915;5296.841094767163;5209.270702101709;5251.55361794248;5251.789928402859;5254;5290.444503327153;5056.6713163644245;5108.978204359143;5179.19722443022;5180.430152683201;5190.169572868361;5125.948740512585;5126.820561280338;5148.948510514884;5153.587712982952;5166.948330516684;5296.947030529684;5489.545270503319;5522.171674248895;5621.4659607337235;5623.437656234344;6066.939330606726;6140.62695141751;6230.750769969196;6270.96864515679;6273.937260627381;6177.042558403455;6240.563160578761;6273.1531243282025;6283.842903927392;6300.369963003709;5730.19777231188;5778.797742079091;5780.0751879699465;5789.015867302569;5802.970985145047;6157.507399408037;6172.753089876354;6260.624362538171;6268.905966410507;6274.341194174637;6154.907676384858;6170.228721409824;6172.938270617236;6181.381861813873;6195.535334849904;6234.532410069263;6254.718537665816;6262.655553944485;6268.435840774261;6291.653959032205;5971.5222782177325;6093.39066093396;6101.338204344158;6163.137160797492;6180.134781130645;6187.876242475215;6215.440610345;6224.719887605069;6227.532935029801;6240.126382306481;4921.532454416824;4928.408590969035;4937.284093806378;4937.925931111036;4957.7769000395065;4340.696151269444;4395.582419670126;4436.378906953029;4492.775361231926;4536.387587675687;5697.145428185805;5699.601027928005;5706.686132262766;5707.68607726579;5715.657060576379;6226.439620434183;6231.345708700521;6245.406686364788;6246;6257.687115644199;5505.449455054542;5596.636218645775;5604.971975140098;5611.971940140274;5612.326520817528;5342.732863356817;5344.732763361816;5359.383670877899;5360.839174824761;5364.758585863646;6155.72299246535;6241.968790156111;6342.778002769789;6354.046892966092;6360.204974378203;6238.189035425366;6270.122182894307;6272.780452684134;6281.96859015702;6286.214223222098;6181.598196117238;6317.210348706411;6345.365463453618;6357.427831495188;6363.490920726238;6136.325004249618;6188.195534580475;6198.132261483486;6205.565610407409;6207.099970504342;6201.534884883742;6210;6239.96880015597;6242.53181011435;6246.281677607133;5920.37836027211;5927.051671732502;5986.191864098291;6119.816405507842;6125.84685382869;6039.818805435844;6107.61364822091;6136.3965394158;6140.416660417253;6158.983767678283;5915.231019967377;5931.5847890648965;5942.31663358702;5944.5838791284195;6022.608530445507;6107.480864126599;6117.3270940197435;6120.009562515041;6127.387261273837;6128.8774224516155;5781.959247335351;5846.269216347957;5865.794697185578;5893.116032594973;5897.174395584536 05:52:12 INFO - PROCESS | 2497 | |1;ext.html;520.380746911176;525.8054519827664;527.9155335146378;560.8222732262249;568.5082403720783;28938.855305723468;31382;37540.62459375409;38578.8071059645;38586.84239472813;40761;41340.58659413405;41436.79281603595;41470;41853.79073104638;8451.53516556589;9381;9611.80776384472;9620.71137865865;9621.95189024054;8579.613917373734;11550.8267375989;11859.229150105259;11871.881281187163;11895.04839612829;11600.767984640303;11604.303741775479;11613.361265130414;11756;11785.998190153847;8579.828403431959;11337.603183888607;11398.487068081915;11546.53813847445;11693.590724324693;11374.976252137265;11551.884481155164;11555.364454954974;11556.479958401893;11591.826122608167;37519.437208441894;37981.81009094964;37990.24019519594;38105.80947095247;38230.04424889372;3321.96678033219;3336.9155024616853;3341.214814518586;3503.3168532135987;3661.4324779658928;22003;28130;29605;29646.85176574125;29735.959241426448;2694.0779990257483;2755.600437936488;2787.902423415191;2814.015094716853;2825.6891741908375;484123;484123;484229;486710;486793;34510;35689.64310356863;59339.70330148408;59841.700791495765;60520.39479605236;34337.96986090421;34536.48195277073;34596.135096622784;34598.82700586481;34618;13941.372638231303;14157.362918668685;14158.29208539569;14177.078489898124;14181.716365672628;11115.666530003951;11399.715007124889;12032.458539365749;12286.75426491465;12327.383630818424;7766.417518686121;7878.1334053254095;7923.841523169504;7959.602019898982;8043.39674524413;3361.7057432888514;3399.8300084996145;3406.982965085159;3422.178677117474;3432.708219801345;895.6059333893066;955.2739917662487;1017.4505766885947;1025.6153942271649;1069.4866464097122;29012.70987290142;29096.9816056437;29255.707442925297;29544.282711299606;29934.70065299319;1108.3294606762954;1125.774845030997;1133.9433028348549;1159.996602938469;1240.505191244548;13596.864031359757;13752.862471375358;15030.699386012218;15167.469138580096;15477.761779057648;623387;631773;632472;633381;633760;56926;58909.705451472466;58962.41037589569;58963.705181473815;59106;1321.2468892731242;1350.3045931345562;1436.705475377566;1449.9782503262459;1489.3074720255133;28007.719922800512;28190;28896.855515723128;29252.793226858532;29346;47081.05837883292;47194.29208561943;47677.80805479891;47761.044779103526;47772.522274776806;351953;353686;353789;353933;354526;21934.780652193273;22782.38002629719;25602.9758809653;26728;26782.062627807933;42376.36435453409;43265.567344326155;43465.56534434615;43621.34567981419;44128.89677757953;35802;36035.63964360323;36092.458613120296;36846;36954.44568331531;35859.282814343045;36118;37129;37732.62267377291;38009.619903801715;26749;33747.83126084354;34068.829655851565;34138;34590.96227113191;25119.729645960597;30798.84600576983;32022.758406912224;32267.838660806545;32316.86890958805;23744.643830342906;23986.920588573907;23988.52022959496;24348.391290217885;24462 05:52:12 INFO - PROCESS | 2497 | |2;jquery.html;327.78202495340594;394.5147468613605;401.6706300833318;408.21622484829123;416.26113648274327;17448.56378590536;20302.796972030275;21512.677309840365;21519.462013449673;21524.354269371925;12112.9703975162;12446.626601201955;12452.626421207355;12686.61940141795;19554.51113722154;5351.277577527042;5539.639923404986;5562.110062390018;5567.944320556783;5586.86032849178;3922.2547715934024;3948.644621984021;4153.8961525961795;6143.201383820097;6169.722362493699;5331.893362132755;5746.477183546363;6037.667928263943;6161.322254551996;6176.72204750785;5413.891722165555;6151.600145990541;6165.969170154143;6167.814965551041;6169.907451388232;3778.3199024175638;5487.533559647435;5855.590108692393;5883.205767221413;5885;13852.584422467342;13955;17866;24647.876760616262;24672.766361681843;2208.8895555222175;2243.069126312578;2310.1567927706265;2369.3721163891582;2508.6989561252767;9793.608255669764;9995.350302230332;10093.343932644355;10287.485625718758;10484.842727359095;1736.6222399045132;1784.5717027913338;1812.2026308424252;1812.5378028602622;1896.2794138227523;118629;124172.27483175609;124887;125901.37049314786;127637;10168.796624067478;11234.550617975354;11537.88462115368;11929.463174157183;12001.39993000364;15393.692126157413;15461.381544738084;15461.768073478906;15488;15510.689786204213;8704.26013788835;8761.518116503654;8795.296376289882;8813.823723525493;8935.597898094602;8547.786305342292;8556.957215214008;8573.871391929126;8710.695125670698;8720.78198045054;4650.209464391061;4679.22792739201;4701.78841952113;4709.505501922249;4759.881002974884;1696.414736915762;1786.7051936430344;1828.8207874640432;1848.8983105929035;1966.9803301966797;824.3734761581242;939.4645052320249;942.0626476655634;948.3551185193996;969.5782334684435;19368.93470859088;19992;20097.296594619118;20533.897330513253;20754.06606702702;946.5598496699068;961.7980224153006;968.2883080935507;987.4717026390847;1028.5114570579065;9054.411463254868;10200.387976721273;10721.946390267998;11160.274582152297;11247.606333778442;561624;568383;570364;612929;617977;130024;132385;135877;136927;139373.30313348369;1016.5679586175846;1041.2971244409994;1060.8143574874366;1062.7768168684509;1065.7016035510069;18317.633647327246;18371.357002504847;18410.26358945681;18438.89366638006;18576.349827756505;50980.490195097576;51827;52047;52326;52654;71986.64006679933;77400.61299693465;78694.60652696699;78867.21132788828;81272.5936370338;7048.118985126859;7539.246075392417;7567.508111972704;7605.011348524657;7896.565688887166;12568.057395695543;13075.673108171992;13095.476180952655;13270.933645331712;13382.13016153947;11042.282251653938;11114.610988615359;11270.492827822603;11301.830472542753;11377.374244416636;11060.446977651247;11201.66395008151;11289.927456891583;11298.152638552307;11391.202615817145;11088.889111109109;11298.152638551977;11430.1998860079;11709.063274938155;11781.52873885035;7522.210167932507;7593.658285377061;7753.263439973193;7773.339266162213;7916;10760.946195268974;11096.167787415814;11186.301753263811;11202.258004996747;11385.886141138482 05:52:12 INFO - PROCESS | 2497 | |3;mootools.html;1418.3192067807445;1593.9760903586448;1607.7427611582148;1881.7835948865884;2000.739903812504;7970.60146992651;8671.17623825737;8885.644574217024;8892.37753357266;8919.286457083434;8393.748187554384;8709.825803483927;8714.128587141282;8715.564221788902;8720.34597405194;2440.0239904038394;2475.232677869866;2477.7398373170827;2479.1942618648923;2479.2438306316567;2411.1922505960524;2474.9752502475017;2475.616279476684;2477.34350397144;2480.8015358771345;2434.1358817619757;2464.617984212441;2477.6283557466345;2483.3915690655726;2485.465624890648;2410.758924107593;2435.2207293666033;2442.9617412599664;2449.7182823975113;2464.2114523352534;2393.1265088242667;2426.9757302426924;2442.9877850610633;2443.3402981194977;2455.091616102036;8573.957130214372;8712.825743485158;8751.562421878943;8809.075047120024;8865.645374185026;5286.841394758125;5454.945450545483;5465.699386533739;5488.396276409591;5488.835334939959;3448.189675426298;3572.7499075064757;3654.9086272843124;3664.633536646341;3677.9517837416206;1021.5249908792373;1032.8967103289685;1037.444966942682;1044.6709286574705;1046.712154157605;10750.892491075145;11513.194076414655;11528.42357882111;11536.365499897502;11542.36516991565;4471.776411179428;4505.81976720934;4715.552022557851;4744.4069491313585;4747.121782470254;9230.307726920508;9247.352685312098;9262.16640502358;9264.7683807904;9287.328280909502;5330.307060082242;5331.253624492574;5347.385050719217;5363.195520671852;5403.054465468527;4445.310976798602;4482.9775851121185;4832.710037397767;4874.025194961022;5054.292399064134;3830.540335159799;3837.4052021936645;3924.823382947717;3926.411038344214;3937.4487571739405;1204.27141579345;1217.9269243845397;1223.174357308813;1230.1880758699215;1238.7708273969345;669.4242951062083;798.5683593457934;813.2193094629104;869.2003356911656;988.7033889833021;5782.306123265235;5796.88406231873;6006.939930600725;6054.455099041107;6067.423594758491;958.3243813111878;970.5486948568949;980.6959842448864;994.2046362909643;1018.1193267823428;3364.9327013459592;3895.8441662333757;4042.130941847517;4058.859962837889;4070.2063097695664;9296.72109836706;10399.116075133546;10476;10958;10961.342319460859;10811.945940270249;10881.347119172875;10887.891121088845;10895.509702063426;10905.127589792797;8227.629756660845;8307.6676932922;8361.122082181406;8426.241638252464;8427.662893484192;5620.100783874561;5862.853428664317;5911;5925.4370834770625;5952.8809423812145;9554.28342874301;9616.855747163938;9816.950915245377;9923.057309555581;9930.05664461875;9897.50512474359;10025.699229023141;10046.799064018825;10128.544215510467;10139.695809125738;7463.179050304354;7572.3942084632;7603.619819009138;7616.466847320856;7627.771166865003;8082;8232.958835205785;8240.546769927712;8367.330613551023;8395.412321137463;7248.637568121468;7412.332890039922;7414.777556673308;7494.737684181027;7573.2048134945035;7346;7380.18817930038;7432.851342973218;7522.435817313614;7589.6584653689615;7061.2938706131035;7144.67848946809;7152.320529549685;7163.677634506564;7180.461465390013;4797.808087676453;4935.851924442272;4982.327385803015;5038.647294689336;5215.139501982282;4954.65317427791;5001.4998500149695;5091.567216786615;5142.074426603247;5155.639105262596 05:52:12 INFO - PROCESS | 2497 | |4;prototype.html;258.65857068669357;324.40471734367435;327.65923439622793;331.70975396528024;337.09153830426976;5453.291072160619;6024.5782795204295;6050.304215015274;6093.573449858512;6110.602810817294;4891.926621100686;5901.675407852566;5965.761369545213;5967.88064238716;6018.8796224075495;4251.4685664291965;4307.978460107695;4392.34114882767;4475.865724028268;4552.499225085255;4449.7997590108525;4464.6874718769695;4476.664250181233;4490.326451032339;4491.39366185564;3877.6510114089724;4067.3085575452096;4486;4492.213862574036;4504.797284122206;4252.957470425303;4367.667861302301;4372.360364863176;4520.4575450946095;4537.9773101134615;3447.4311738563106;3828.3300422425964;3884.6892248620043;3917.314469967744;3921.392184211452;5530.474604912567;5561.499465048165;5824.155497452888;5854.736536855852;5858.297004359461;4508.2868509966;4828.420589529243;4976.676516026447;5126.948730512684;5178.016176926372;6326.4938804895955;6361;6368;6380.298167201604;6384.648844313561;3507.088157079152;4007.979960100181;4222.387753775716;4225.661947044229;4234.195502854448;5251.030863426216;5865.85335366615;6731.495137864631;6762.898556521656;6773.695183716744;3650.3976843821;4246.808893599796;4269.124829409963;4273.63674087706;4278.743275403485;3875.379939209713;4289.635380992589;4302.526722060571;4362.323839804835;4370.8033138508845;4891.657583969088;5065.8733531662;5126.564242039394;5163.302954101148;5164.354455693038;5676.318841739017;6415.486761059104;6417.550771445954;6428.77853207889;6441.871162576722;1430.1990885104374;1468.6475245940896;1493.4772829509584;1499.4601943300404;1509.3208056374676;903.7333986474006;950.7242899559188;959.3764053365369;974.1086905481546;978.4765150644513;4802.399700037496;5729.799457019068;5853.09277062056;6043.7884674036195;6095.420935011167;5592.86017849557;6614.371634694697;6639.402453779183;6675.165604299463;6704.128463299838;5857.970710146422;6010.429009244115;6034.426729460694;6037.667928263988;6044.607100538451;3459.9654003460146;3478.956313106058;3487.8081705505933;3520.2431477232008;3527.400341941876;6609.173853268341;6904.930950690529;6979.1973922999505;6996.19543752475;7001.229864714877;6407.583507072025;6739.326067393222;6767.830804229934;6808.2510923798345;6816.4546836252985;5803.158542011384;6417.614943103429;6920.826979325457;6932.7226910923;6966.164060312795;5003.849884503471;5335.573154147736;6620.536562440583;6624.362945937766;6700.43046341047;5519.806806761744;5956.642601443928;6422.678866056585;6555.049517819984;6555.410013098844;6023.765128148631;6591.835204119935;6657.234418041793;6887.276835932155;6890.380760521373;4092.877213683594;4252.87241382759;4294.355846622907;4303.1393721255245;4311.461067366579;6302.558820882494;6548.934510654833;6675.59946403198;6694.4644428444635;6695.866082678222;5361.812336568201;5498.95519851227;6370.331115232834;6449.580777249464;6503;5333.759980800951;6234.82143300581;6415.390537898892;6439.162908821823;6441.581297215666;5367.5169234769055;5529.30883639545;5820.894030134261;6189.535784816067;6318.399752023551;6272.937270627235;6428.614283143026;6448;6474.870502590016;6511.934880651323;5248.737563121905;5636.2744077451025;5773.84523095391;6316.968415157895;6395.744170233324 05:52:12 INFO - PROCESS | 2497 | |5;yui.html;638.3705221277037;647.8477557773925;657.4346062386348;744.8175197076717;774.1909704358944;14957.775633365494;15268.236588170603;15314.387424503035;15371.538853834389;15431.845681543182;13651.385687644055;14086.366113524891;14135.293235338218;14138.858611413909;14275.428982840675;930.8045310484806;933.6545478173051;946.8921362006434;948.9003654616234;951.3720944176845;909.295296145486;921.8156368726249;922.903095175007;922.9723108306762;929.7675581104724;887.5695287785419;970.9320347575673;976.1263669016226;976.8046390721848;980.5734505490099;971.3880255439063;972.1008067537499;972.2270794718181;972.4651441707033;981;724.2974314914577;725.9782206533813;726.2048057377164;727.1274470635205;728.0171768113058;13290.20258784476;13508.257045862474;13524.729505409936;13583.320833958362;13897.374618142208;11310.943445282803;11458.942705286503;11558.30650160993;11598.826017609743;12026.879731202664;9480.241580673599;9577.377470464398;9858.753531161707;9985.500724963722;10112.89887101127;3469.4969229461585;3491.2319289756215;3561.5013898054294;3565.7682250653884;3654.926901461956;58599.41400585982;62625;67139.66430167867;77876.83184752177;81922.59038704827;10056.899431005742;10068.899311006942;10121.392716437038;10381.740456488647;10485.056344928993;21954.560908781736;21987.780122198572;22025;22032.33902982913;22070.448238794157;6500.902486462707;7527.585982771;7555.09338879327;7685.923140768521;7698.92301076982;4121.9381709274385;4148.57023730931;4253.680973926967;4275.230458517497;4279.807408666617;3447.844846981892;3571.714262858965;3571.910702232465;3573.4997100405963;3574.088607405147;634.7238951056305;643.029026170486;646.1664452855857;650.5413683353224;651.5146216068964;518.7043385270359;549.6177114556892;569.291232415637;577.177522031104;596.2546816479401;7097.183823860219;7606.733764318223;7795.668075382066;7846.5292082475235;7910.248526389983;496.20607028754426;505.72690746996943;535.2159086937655;559.5663360895257;562.1876388618489;3235.482322828383;3419.8803041893416;3684.5762737285554;3737.71967102463;3790.045553908737;70813.64593177;72193;72370;72468.27531724615;72994.63502682453;67219;67712;68054.65972670105;68119;68218.65890670515;48650;58523.24430267099;62731;67301;68178.97731534031;6413.909635361906;7784.766457006299;7813.374930005472;7947.483413578099;8026.1171271158955;35713.1071723209;37554.248915021;39056.804715976235;39159.62941297041;40257.39613905735;55425.44574554203;56286;56749.71625141848;56856;57003.714981424826;11043.282186657842;11223.831642525205;11255.099592032453;11295.039921606756;11571.942140289244;11764.117691173025;12091.516339346328;12124.33316167584;12243.32661703615;12913.031522635652;11405.429728513374;11764.416308125485;11932.761344772882;11943.76112477763;12053.698657533632;8993.730188094367;11103.555857765921;11249.66251012471;11555.364454954723;11616.070714343;11051.778964420506;11522.481488333213;11525.135614828754;11758.647240582795;12310.938445308075;9292.674756383494;9597.47213903242;9719.590659354495;9982.301238913205;10089.142422894136;8871.600777964877;9605.711828645151;9661.323707340418;9698.46658433793;9811.411315321104 05:52:12 INFO - PROCESS | 2497 | __end_tp_report 05:52:12 INFO - PROCESS | 2497 | __start_cc_report 05:52:12 INFO - PROCESS | 2497 | _x_x_mozilla_cycle_collect,1430 05:52:12 INFO - PROCESS | 2497 | __end_cc_report 05:52:12 INFO - PROCESS | 2497 | __startTimestamp1460551932591__endTimestamp 05:52:12 INFO - PROCESS | 2497 | 05:52:12 INFO - PROCESS | 2497 | ------- Summary: start ------- 05:52:12 INFO - PROCESS | 2497 | Number of tests: 6 05:52:12 INFO - PROCESS | 2497 | 05:52:12 INFO - PROCESS | 2497 | [#0] dojo.html Cycles:165 Average:5731.46 Median:5927.05 stddev:629.11 (10.6%) stddev-sans-first:603.29 05:52:12 INFO - PROCESS | 2497 | Values: 3375.8 3434.3 3454.6 3479.1 3495.2 5562.5 5638.9 5659.6 5661.5 5665.9 5632.7 5772.9 5775.7 5777.4 5850.9 5142.9 5167.1 5170.9 5207.1 5209.7 5109.2 5228.7 5256.2 5280.4 5296.8 5209.3 5251.6 5251.8 5254.0 5290.4 5056.7 5109.0 5179.2 5180.4 5190.2 5125.9 5126.8 5148.9 5153.6 5166.9 5296.9 5489.5 5522.2 5621.5 5623.4 6066.9 6140.6 6230.8 6271.0 6273.9 6177.0 6240.6 6273.2 6283.8 6300.4 5730.2 5778.8 5780.1 5789.0 5803.0 6157.5 6172.8 6260.6 6268.9 6274.3 6154.9 6170.2 6172.9 6181.4 6195.5 6234.5 6254.7 6262.7 6268.4 6291.7 5971.5 6093.4 6101.3 6163.1 6180.1 6187.9 6215.4 6224.7 6227.5 6240.1 4921.5 4928.4 4937.3 4937.9 4957.8 4340.7 4395.6 4436.4 4492.8 4536.4 5697.1 5699.6 5706.7 5707.7 5715.7 6226.4 6231.3 6245.4 6246.0 6257.7 5505.4 5596.6 5605.0 5612.0 5612.3 5342.7 5344.7 5359.4 5360.8 5364.8 6155.7 6242.0 6342.8 6354.0 6360.2 6238.2 6270.1 6272.8 6282.0 6286.2 6181.6 6317.2 6345.4 6357.4 6363.5 6136.3 6188.2 6198.1 6205.6 6207.1 6201.5 6210.0 6240.0 6242.5 6246.3 5920.4 5927.1 5986.2 6119.8 6125.8 6039.8 6107.6 6136.4 6140.4 6159.0 5915.2 5931.6 5942.3 5944.6 6022.6 6107.5 6117.3 6120.0 6127.4 6128.9 5782.0 5846.3 5865.8 5893.1 5897.2 05:52:12 INFO - PROCESS | 2497 | 05:52:12 INFO - PROCESS | 2497 | [#1] ext.html Cycles:180 Average:61280.49 Median:18737.91 stddev:134620.55 (718.4%) stddev-sans-first:134920.90 05:52:12 INFO - PROCESS | 2497 | Values: 520.4 525.8 527.9 560.8 568.5 28938.9 31382.0 37540.6 38578.8 38586.8 40761.0 41340.6 41436.8 41470.0 41853.8 8451.5 9381.0 9611.8 9620.7 9622.0 8579.6 11550.8 11859.2 11871.9 11895.0 11600.8 11604.3 11613.4 11756.0 11786.0 8579.8 11337.6 11398.5 11546.5 11693.6 11375.0 11551.9 11555.4 11556.5 11591.8 37519.4 37981.8 37990.2 38105.8 38230.0 3322.0 3336.9 3341.2 3503.3 3661.4 22003.0 28130.0 29605.0 29646.9 29736.0 2694.1 2755.6 2787.9 2814.0 2825.7 484123.0 484123.0 484229.0 486710.0 486793.0 34510.0 35689.6 59339.7 59841.7 60520.4 34338.0 34536.5 34596.1 34598.8 34618.0 13941.4 14157.4 14158.3 14177.1 14181.7 11115.7 11399.7 12032.5 12286.8 12327.4 7766.4 7878.1 7923.8 7959.6 8043.4 3361.7 3399.8 3407.0 3422.2 3432.7 895.6 955.3 1017.5 1025.6 1069.5 29012.7 29097.0 29255.7 29544.3 29934.7 1108.3 1125.8 1133.9 1160.0 1240.5 13596.9 13752.9 15030.7 15167.5 15477.8 623387.0 631773.0 632472.0 633381.0 633760.0 56926.0 58909.7 58962.4 58963.7 59106.0 1321.2 1350.3 1436.7 1450.0 1489.3 28007.7 28190.0 28896.9 29252.8 29346.0 47081.1 47194.3 47677.8 47761.0 47772.5 351953.0 353686.0 353789.0 353933.0 354526.0 21934.8 22782.4 25603.0 26728.0 26782.1 42376.4 43265.6 43465.6 43621.3 44128.9 35802.0 36035.6 36092.5 36846.0 36954.4 35859.3 36118.0 37129.0 37732.6 38009.6 26749.0 33747.8 34068.8 34138.0 34591.0 25119.7 30798.8 32022.8 32267.8 32316.9 23744.6 23986.9 23988.5 24348.4 24462.0 05:52:12 INFO - PROCESS | 2497 | 05:52:12 INFO - PROCESS | 2497 | [#2] jquery.html Cycles:180 Average:34634.36 Median:11866.62 stddev:98446.53 (829.6%) stddev-sans-first:98689.00 05:52:12 INFO - PROCESS | 2497 | Values: 327.8 394.5 401.7 408.2 416.3 17448.6 20302.8 21512.7 21519.5 21524.4 12113.0 12446.6 12452.6 12686.6 19554.5 5351.3 5539.6 5562.1 5567.9 5586.9 3922.3 3948.6 4153.9 6143.2 6169.7 5331.9 5746.5 6037.7 6161.3 6176.7 5413.9 6151.6 6166.0 6167.8 6169.9 3778.3 5487.5 5855.6 5883.2 5885.0 13852.6 13955.0 17866.0 24647.9 24672.8 2208.9 2243.1 2310.2 2369.4 2508.7 9793.6 9995.4 10093.3 10287.5 10484.8 1736.6 1784.6 1812.2 1812.5 1896.3 118629.0 124172.3 124887.0 125901.4 127637.0 10168.8 11234.6 11537.9 11929.5 12001.4 15393.7 15461.4 15461.8 15488.0 15510.7 8704.3 8761.5 8795.3 8813.8 8935.6 8547.8 8557.0 8573.9 8710.7 8720.8 4650.2 4679.2 4701.8 4709.5 4759.9 1696.4 1786.7 1828.8 1848.9 1967.0 824.4 939.5 942.1 948.4 969.6 19368.9 19992.0 20097.3 20533.9 20754.1 946.6 961.8 968.3 987.5 1028.5 9054.4 10200.4 10721.9 11160.3 11247.6 561624.0 568383.0 570364.0 612929.0 617977.0 130024.0 132385.0 135877.0 136927.0 139373.3 1016.6 1041.3 1060.8 1062.8 1065.7 18317.6 18371.4 18410.3 18438.9 18576.3 50980.5 51827.0 52047.0 52326.0 52654.0 71986.6 77400.6 78694.6 78867.2 81272.6 7048.1 7539.2 7567.5 7605.0 7896.6 12568.1 13075.7 13095.5 13270.9 13382.1 11042.3 11114.6 11270.5 11301.8 11377.4 11060.4 11201.7 11289.9 11298.2 11391.2 11088.9 11298.2 11430.2 11709.1 11781.5 7522.2 7593.7 7753.3 7773.3 7916.0 10760.9 11096.2 11186.3 11202.3 11385.9 05:52:12 INFO - PROCESS | 2497 | 05:52:12 INFO - PROCESS | 2497 | [#3] mootools.html Cycles:180 Average:5707.61 Median:5116.82 stddev:3139.90 (61.4%) stddev-sans-first:3132.16 05:52:12 INFO - PROCESS | 2497 | Values: 1418.3 1594.0 1607.7 1881.8 2000.7 7970.6 8671.2 8885.6 8892.4 8919.3 8393.7 8709.8 8714.1 8715.6 8720.3 2440.0 2475.2 2477.7 2479.2 2479.2 2411.2 2475.0 2475.6 2477.3 2480.8 2434.1 2464.6 2477.6 2483.4 2485.5 2410.8 2435.2 2443.0 2449.7 2464.2 2393.1 2427.0 2443.0 2443.3 2455.1 8574.0 8712.8 8751.6 8809.1 8865.6 5286.8 5454.9 5465.7 5488.4 5488.8 3448.2 3572.7 3654.9 3664.6 3678.0 1021.5 1032.9 1037.4 1044.7 1046.7 10750.9 11513.2 11528.4 11536.4 11542.4 4471.8 4505.8 4715.6 4744.4 4747.1 9230.3 9247.4 9262.2 9264.8 9287.3 5330.3 5331.3 5347.4 5363.2 5403.1 4445.3 4483.0 4832.7 4874.0 5054.3 3830.5 3837.4 3924.8 3926.4 3937.4 1204.3 1217.9 1223.2 1230.2 1238.8 669.4 798.6 813.2 869.2 988.7 5782.3 5796.9 6006.9 6054.5 6067.4 958.3 970.5 980.7 994.2 1018.1 3364.9 3895.8 4042.1 4058.9 4070.2 9296.7 10399.1 10476.0 10958.0 10961.3 10811.9 10881.3 10887.9 10895.5 10905.1 8227.6 8307.7 8361.1 8426.2 8427.7 5620.1 5862.9 5911.0 5925.4 5952.9 9554.3 9616.9 9817.0 9923.1 9930.1 9897.5 10025.7 10046.8 10128.5 10139.7 7463.2 7572.4 7603.6 7616.5 7627.8 8082.0 8233.0 8240.5 8367.3 8395.4 7248.6 7412.3 7414.8 7494.7 7573.2 7346.0 7380.2 7432.9 7522.4 7589.7 7061.3 7144.7 7152.3 7163.7 7180.5 4797.8 4935.9 4982.3 5038.6 5215.1 4954.7 5001.5 5091.6 5142.1 5155.6 05:52:12 INFO - PROCESS | 2497 | 05:52:12 INFO - PROCESS | 2497 | [#4] prototype.html Cycles:180 Average:5133.32 Median:5812.03 stddev:1627.71 (28.0%) stddev-sans-first:1590.62 05:52:12 INFO - PROCESS | 2497 | Values: 258.7 324.4 327.7 331.7 337.1 5453.3 6024.6 6050.3 6093.6 6110.6 4891.9 5901.7 5965.8 5967.9 6018.9 4251.5 4308.0 4392.3 4475.9 4552.5 4449.8 4464.7 4476.7 4490.3 4491.4 3877.7 4067.3 4486.0 4492.2 4504.8 4253.0 4367.7 4372.4 4520.5 4538.0 3447.4 3828.3 3884.7 3917.3 3921.4 5530.5 5561.5 5824.2 5854.7 5858.3 4508.3 4828.4 4976.7 5126.9 5178.0 6326.5 6361.0 6368.0 6380.3 6384.6 3507.1 4008.0 4222.4 4225.7 4234.2 5251.0 5865.9 6731.5 6762.9 6773.7 3650.4 4246.8 4269.1 4273.6 4278.7 3875.4 4289.6 4302.5 4362.3 4370.8 4891.7 5065.9 5126.6 5163.3 5164.4 5676.3 6415.5 6417.6 6428.8 6441.9 1430.2 1468.6 1493.5 1499.5 1509.3 903.7 950.7 959.4 974.1 978.5 4802.4 5729.8 5853.1 6043.8 6095.4 5592.9 6614.4 6639.4 6675.2 6704.1 5858.0 6010.4 6034.4 6037.7 6044.6 3460.0 3479.0 3487.8 3520.2 3527.4 6609.2 6904.9 6979.2 6996.2 7001.2 6407.6 6739.3 6767.8 6808.3 6816.5 5803.2 6417.6 6920.8 6932.7 6966.2 5003.8 5335.6 6620.5 6624.4 6700.4 5519.8 5956.6 6422.7 6555.0 6555.4 6023.8 6591.8 6657.2 6887.3 6890.4 4092.9 4252.9 4294.4 4303.1 4311.5 6302.6 6548.9 6675.6 6694.5 6695.9 5361.8 5499.0 6370.3 6449.6 6503.0 5333.8 6234.8 6415.4 6439.2 6441.6 5367.5 5529.3 5820.9 6189.5 6318.4 6272.9 6428.6 6448.0 6474.9 6511.9 5248.7 5636.3 5773.8 6317.0 6395.7 05:52:12 INFO - PROCESS | 2497 | 05:52:12 INFO - PROCESS | 2497 | [#5] yui.html Cycles:180 Average:16213.40 Median:56517.86 stddev:21303.02 (37.7%) stddev-sans-first:21330.68 05:52:12 INFO - PROCESS | 2497 | Values: 638.4 647.8 657.4 744.8 774.2 14957.8 15268.2 15314.4 15371.5 15431.8 13651.4 14086.4 14135.3 14138.9 14275.4 930.8 933.7 946.9 948.9 951.4 909.3 921.8 922.9 923.0 929.8 887.6 970.9 976.1 976.8 980.6 971.4 972.1 972.2 972.5 981.0 724.3 726.0 726.2 727.1 728.0 13290.2 13508.3 13524.7 13583.3 13897.4 11310.9 11458.9 11558.3 11598.8 12026.9 9480.2 9577.4 9858.8 9985.5 10112.9 3469.5 3491.2 3561.5 3565.8 3654.9 58599.4 62625.0 67139.7 77876.8 81922.6 10056.9 10068.9 10121.4 10381.7 10485.1 21954.6 21987.8 22025.0 22032.3 22070.4 6500.9 7527.6 7555.1 7685.9 7698.9 4121.9 4148.6 4253.7 4275.2 4279.8 3447.8 3571.7 3571.9 3573.5 3574.1 634.7 643.0 646.2 650.5 651.5 518.7 549.6 569.3 577.2 596.3 7097.2 7606.7 7795.7 7846.5 7910.2 496.2 505.7 535.2 559.6 562.2 3235.5 3419.9 3684.6 3737.7 3790.0 70813.6 72193.0 72370.0 72468.3 72994.6 67219.0 67712.0 68054.7 68119.0 68218.7 48650.0 58523.2 62731.0 67301.0 68179.0 6413.9 7784.8 7813.4 7947.5 8026.1 35713.1 37554.2 39056.8 39159.6 40257.4 55425.4 56286.0 56749.7 56856.0 57003.7 11043.3 11223.8 11255.1 11295.0 11571.9 11764.1 12091.5 12124.3 12243.3 12913.0 11405.4 11764.4 11932.8 11943.8 12053.7 8993.7 11103.6 11249.7 11555.4 11616.1 11051.8 11522.5 11525.1 11758.6 12310.9 9292.7 9597.5 9719.6 9982.3 10089.1 8871.6 9605.7 9661.3 9698.5 9811.4 05:52:12 INFO - PROCESS | 2497 | -------- Summary: end -------- 05:52:12 INFO - PROCESS | 2497 | 05:52:13 INFO - TEST-INFO | 2497: exit 0 05:52:13 INFO - TEST-OK | dromaeo_css | took 1115335ms 05:52:13 INFO - TEST-START | kraken 05:52:13 INFO - operating with platform_type : mac_ 05:52:13 INFO - Initialising browser for kraken test... 05:52:13 INFO - TEST-INFO | started process 2500 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpXRnBJP/profile http://localhost:51521/getInfo.html) 05:52:15 INFO - PROCESS | 2500 | __metrics Screen width/height:1600/1200 05:52:15 INFO - PROCESS | 2500 | colorDepth:24 05:52:15 INFO - PROCESS | 2500 | Browser inner width/height: 1024/689 05:52:15 INFO - PROCESS | 2500 | __metrics 05:52:15 INFO - PROCESS | 2500 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:52:15 ERROR - PROCESS | 2500 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:52:16 INFO - TEST-INFO | 2500: exit 0 05:52:16 INFO - Browser initialized. 05:52:16 INFO - Running cycle 1/1 for kraken test... 05:52:16 INFO - TEST-INFO | started process 2502 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpXRnBJP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:28 INFO - PROCESS | 2502 | RSS: Main: 237314048 05:52:28 INFO - PROCESS | 2502 | 05:52:31 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51521/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:31 INFO - PROCESS | 2502 | RSS: Main: 286404608 05:52:31 INFO - PROCESS | 2502 | 05:52:34 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51521/tests/kraken/driver.html?testName=audio-dft) 05:52:35 INFO - PROCESS | 2502 | RSS: Main: 298897408 05:52:35 INFO - PROCESS | 2502 | 05:52:38 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51521/tests/kraken/driver.html?testName=audio-fft) 05:52:39 INFO - PROCESS | 2502 | RSS: Main: 383414272 05:52:39 INFO - PROCESS | 2502 | 05:52:41 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51521/tests/kraken/driver.html?testName=audio-oscillator) 05:52:42 INFO - PROCESS | 2502 | RSS: Main: 286494720 05:52:42 INFO - PROCESS | 2502 | 05:52:44 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51521/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:44 INFO - PROCESS | 2502 | RSS: Main: 290426880 05:52:44 INFO - PROCESS | 2502 | 05:52:47 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51521/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:48 INFO - PROCESS | 2502 | RSS: Main: 326860800 05:52:48 INFO - PROCESS | 2502 | 05:52:51 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51521/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:51 INFO - PROCESS | 2502 | RSS: Main: 327503872 05:52:51 INFO - PROCESS | 2502 | 05:52:54 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51521/tests/kraken/driver.html?testName=json-parse-financial) 05:52:55 INFO - PROCESS | 2502 | RSS: Main: 327024640 05:52:55 INFO - PROCESS | 2502 | 05:52:56 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51521/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:57 INFO - PROCESS | 2502 | RSS: Main: 319782912 05:52:57 INFO - PROCESS | 2502 | 05:52:59 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:59 INFO - PROCESS | 2502 | RSS: Main: 326762496 05:52:59 INFO - PROCESS | 2502 | 05:53:02 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:02 INFO - PROCESS | 2502 | RSS: Main: 329400320 05:53:02 INFO - PROCESS | 2502 | 05:53:05 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:06 INFO - PROCESS | 2502 | RSS: Main: 334184448 05:53:06 INFO - PROCESS | 2502 | 05:53:09 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:09 INFO - PROCESS | 2502 | RSS: Main: 331886592 05:53:09 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | Cycle 1(1): loaded http://localhost:51521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51521/tests/kraken/driver.html?testName=ai-astar) 05:53:11 INFO - PROCESS | 2502 | RSS: Main: 395800576 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | __start_tp_report 05:53:11 INFO - PROCESS | 2502 | _x_x_mozilla_page_load 05:53:11 INFO - PROCESS | 2502 | _x_x_mozilla_page_load_details 05:53:11 INFO - PROCESS | 2502 | |i|pagename|runs| 05:53:11 INFO - PROCESS | 2502 | |0;ai-astar;111;110;113;127;113;113;120;112;112;112 05:53:11 INFO - PROCESS | 2502 | |1;audio-beat-detection;157;123;148;172;123;147;141;119;199;149 05:53:11 INFO - PROCESS | 2502 | |2;audio-dft;185;188;187;184;199;250;182;184;183;184 05:53:11 INFO - PROCESS | 2502 | |3;audio-fft;81;73;87;93;55;59;57;79;83;55 05:53:11 INFO - PROCESS | 2502 | |4;audio-oscillator;94;94;137;77;77;77;128;79;76;125 05:53:11 INFO - PROCESS | 2502 | |5;imaging-gaussian-blur;102;131;105;84;87;85;97;131;134;84 05:53:11 INFO - PROCESS | 2502 | |6;imaging-darkroom;93;94;94;93;93;95;93;93;93;93 05:53:11 INFO - PROCESS | 2502 | |7;imaging-desaturate;85;84;85;86;86;85;84;84;83;80 05:53:11 INFO - PROCESS | 2502 | |8;json-parse-financial;60;61;60;60;59;59;58;77;60;56 05:53:11 INFO - PROCESS | 2502 | |9;json-stringify-tinderbox;60;60;78;73;69;68;67;67;67;69 05:53:11 INFO - PROCESS | 2502 | |10;stanford-crypto-aes;84;86;86;87;84;102;104;114;87;84 05:53:11 INFO - PROCESS | 2502 | |11;stanford-crypto-ccm;149;145;148;164;127;166;170;160;183;146 05:53:11 INFO - PROCESS | 2502 | |12;stanford-crypto-pbkdf2;170;169;173;170;176;172;168;201;222;179 05:53:11 INFO - PROCESS | 2502 | |13;stanford-crypto-sha256-iterative;69;69;69;68;67;67;66;70;69;68 05:53:11 INFO - PROCESS | 2502 | __end_tp_report 05:53:11 INFO - PROCESS | 2502 | __start_cc_report 05:53:11 INFO - PROCESS | 2502 | _x_x_mozilla_cycle_collect,1949 05:53:11 INFO - PROCESS | 2502 | __end_cc_report 05:53:11 INFO - PROCESS | 2502 | __startTimestamp1460551991913__endTimestamp 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | ------- Summary: start ------- 05:53:11 INFO - PROCESS | 2502 | Number of tests: 14 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#0] ai-astar Cycles:10 Average:114.30 Median:113.00 stddev:5.21 (4.6%) stddev-sans-first:5.39 05:53:11 INFO - PROCESS | 2502 | Values: 111.0 110.0 113.0 127.0 113.0 113.0 120.0 112.0 112.0 112.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:148.50 stddev:24.49 (16.5%) stddev-sans-first:25.75 05:53:11 INFO - PROCESS | 2502 | Values: 157.0 123.0 148.0 172.0 123.0 147.0 141.0 119.0 199.0 149.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#2] audio-dft Cycles:10 Average:192.60 Median:186.00 stddev:20.74 (11.2%) stddev-sans-first:21.82 05:53:11 INFO - PROCESS | 2502 | Values: 185.0 188.0 187.0 184.0 199.0 250.0 182.0 184.0 183.0 184.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#3] audio-fft Cycles:10 Average:72.20 Median:80.00 stddev:14.49 (18.1%) stddev-sans-first:15.01 05:53:11 INFO - PROCESS | 2502 | Values: 81.0 73.0 87.0 93.0 55.0 59.0 57.0 79.0 83.0 55.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:77.00 stddev:24.32 (31.6%) stddev-sans-first:25.78 05:53:11 INFO - PROCESS | 2502 | Values: 94.0 94.0 137.0 77.0 77.0 77.0 128.0 79.0 76.0 125.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#5] imaging-gaussian-blur Cycles:10 Average:104.00 Median:84.00 stddev:20.71 (24.7%) stddev-sans-first:21.96 05:53:11 INFO - PROCESS | 2502 | Values: 102.0 131.0 105.0 84.0 87.0 85.0 97.0 131.0 134.0 84.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 05:53:11 INFO - PROCESS | 2502 | Values: 93.0 94.0 94.0 93.0 93.0 95.0 93.0 93.0 93.0 93.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:85.00 stddev:1.75 (2.1%) stddev-sans-first:1.83 05:53:11 INFO - PROCESS | 2502 | Values: 85.0 84.0 85.0 86.0 86.0 85.0 84.0 84.0 83.0 80.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:60.00 stddev:5.79 (9.7%) stddev-sans-first:6.13 05:53:11 INFO - PROCESS | 2502 | Values: 60.0 61.0 60.0 60.0 59.0 59.0 58.0 77.0 60.0 56.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.50 stddev:5.35 (7.8%) stddev-sans-first:4.87 05:53:11 INFO - PROCESS | 2502 | Values: 60.0 60.0 78.0 73.0 69.0 68.0 67.0 67.0 67.0 69.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:85.00 stddev:10.76 (12.7%) stddev-sans-first:11.03 05:53:11 INFO - PROCESS | 2502 | Values: 84.0 86.0 86.0 87.0 84.0 102.0 104.0 114.0 87.0 84.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#11] stanford-crypto-ccm Cycles:10 Average:155.80 Median:162.00 stddev:15.92 (9.8%) stddev-sans-first:16.69 05:53:11 INFO - PROCESS | 2502 | Values: 149.0 145.0 148.0 164.0 127.0 166.0 170.0 160.0 183.0 146.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:174.50 stddev:17.64 (10.1%) stddev-sans-first:18.33 05:53:11 INFO - PROCESS | 2502 | Values: 170.0 169.0 173.0 170.0 176.0 172.0 168.0 201.0 222.0 179.0 05:53:11 INFO - PROCESS | 2502 | 05:53:11 INFO - PROCESS | 2502 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 05:53:11 INFO - PROCESS | 2502 | Values: 69.0 69.0 69.0 68.0 67.0 67.0 66.0 70.0 69.0 68.0 05:53:11 INFO - PROCESS | 2502 | -------- Summary: end -------- 05:53:11 INFO - PROCESS | 2502 | 05:53:12 INFO - TEST-INFO | 2502: exit 0 05:53:12 INFO - TEST-OK | kraken | took 59423ms 05:53:12 INFO - SUITE-END | took 1174s 05:53:13 INFO - Completed test suite (00:19:35) 05:53:13 INFO - javascript benchmark 05:53:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.848086836092, 3434.313137372526, 3454.6199918009024, 3479.112826229311, 3495.1961048958738, 5562.499375056244, 5638.887222255553, 5659.575531835108, 5661.490465858072, 5665.915011274829, 5632.690202038886, 5772.942270577293, 5775.740091695873, 5777.393373695754, 5850.946829570676, 5142.948570514303, 5167.121589329804, 5170.870728231796, 5207.140821764404, 5209.661372010826, 5109.233614957768, 5228.712420816853, 5256.211568264772, 5280.445553216915, 5296.841094767163, 5209.270702101709, 5251.55361794248, 5251.789928402859, 5254.0, 5290.444503327153, 5056.6713163644245, 5108.978204359143, 5179.19722443022, 5180.430152683201, 5190.169572868361, 5125.948740512585, 5126.820561280338, 5148.948510514884, 5153.587712982952, 5166.948330516684, 5296.947030529684, 5489.545270503319, 5522.171674248895, 5621.4659607337235, 5623.437656234344, 6066.939330606726, 6140.62695141751, 6230.750769969196, 6270.96864515679, 6273.937260627381, 6177.042558403455, 6240.563160578761, 6273.1531243282025, 6283.842903927392, 6300.369963003709, 5730.19777231188, 5778.797742079091, 5780.0751879699465, 5789.015867302569, 5802.970985145047, 6157.507399408037, 6172.753089876354, 6260.624362538171, 6268.905966410507, 6274.341194174637, 6154.907676384858, 6170.228721409824, 6172.938270617236, 6181.381861813873, 6195.535334849904, 6234.532410069263, 6254.718537665816, 6262.655553944485, 6268.435840774261, 6291.653959032205, 5971.5222782177325, 6093.39066093396, 6101.338204344158, 6163.137160797492, 6180.134781130645, 6187.876242475215, 6215.440610345, 6224.719887605069, 6227.532935029801, 6240.126382306481, 4921.532454416824, 4928.408590969035, 4937.284093806378, 4937.925931111036, 4957.7769000395065, 4340.696151269444, 4395.582419670126, 4436.378906953029, 4492.775361231926, 4536.387587675687, 5697.145428185805, 5699.601027928005, 5706.686132262766, 5707.68607726579, 5715.657060576379, 6226.439620434183, 6231.345708700521, 6245.406686364788, 6246.0, 6257.687115644199, 5505.449455054542, 5596.636218645775, 5604.971975140098, 5611.971940140274, 5612.326520817528, 5342.732863356817, 5344.732763361816, 5359.383670877899, 5360.839174824761, 5364.758585863646, 6155.72299246535, 6241.968790156111, 6342.778002769789, 6354.046892966092, 6360.204974378203, 6238.189035425366, 6270.122182894307, 6272.780452684134, 6281.96859015702, 6286.214223222098, 6181.598196117238, 6317.210348706411, 6345.365463453618, 6357.427831495188, 6363.490920726238, 6136.325004249618, 6188.195534580475, 6198.132261483486, 6205.565610407409, 6207.099970504342, 6201.534884883742, 6210.0, 6239.96880015597, 6242.53181011435, 6246.281677607133, 5920.37836027211, 5927.051671732502, 5986.191864098291, 6119.816405507842, 6125.84685382869, 6039.818805435844, 6107.61364822091, 6136.3965394158, 6140.416660417253, 6158.983767678283, 5915.231019967377, 5931.5847890648965, 5942.31663358702, 5944.5838791284195, 6022.608530445507, 6107.480864126599, 6117.3270940197435, 6120.009562515041, 6127.387261273837, 6128.8774224516155, 5781.959247335351, 5846.269216347957, 5865.794697185578, 5893.116032594973, 5897.174395584536], "value": 5691.485520101465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.380746911176, 525.8054519827664, 527.9155335146378, 560.8222732262249, 568.5082403720783, 28938.855305723468, 31382.0, 37540.62459375409, 38578.8071059645, 38586.84239472813, 40761.0, 41340.58659413405, 41436.79281603595, 41470.0, 41853.79073104638, 8451.53516556589, 9381.0, 9611.80776384472, 9620.71137865865, 9621.95189024054, 8579.613917373734, 11550.8267375989, 11859.229150105259, 11871.881281187163, 11895.04839612829, 11600.767984640303, 11604.303741775479, 11613.361265130414, 11756.0, 11785.998190153847, 8579.828403431959, 11337.603183888607, 11398.487068081915, 11546.53813847445, 11693.590724324693, 11374.976252137265, 11551.884481155164, 11555.364454954974, 11556.479958401893, 11591.826122608167, 37519.437208441894, 37981.81009094964, 37990.24019519594, 38105.80947095247, 38230.04424889372, 3321.96678033219, 3336.9155024616853, 3341.214814518586, 3503.3168532135987, 3661.4324779658928, 22003.0, 28130.0, 29605.0, 29646.85176574125, 29735.959241426448, 2694.0779990257483, 2755.600437936488, 2787.902423415191, 2814.015094716853, 2825.6891741908375, 484123.0, 484123.0, 484229.0, 486710.0, 486793.0, 34510.0, 35689.64310356863, 59339.70330148408, 59841.700791495765, 60520.39479605236, 34337.96986090421, 34536.48195277073, 34596.135096622784, 34598.82700586481, 34618.0, 13941.372638231303, 14157.362918668685, 14158.29208539569, 14177.078489898124, 14181.716365672628, 11115.666530003951, 11399.715007124889, 12032.458539365749, 12286.75426491465, 12327.383630818424, 7766.417518686121, 7878.1334053254095, 7923.841523169504, 7959.602019898982, 8043.39674524413, 3361.7057432888514, 3399.8300084996145, 3406.982965085159, 3422.178677117474, 3432.708219801345, 895.6059333893066, 955.2739917662487, 1017.4505766885947, 1025.6153942271649, 1069.4866464097122, 29012.70987290142, 29096.9816056437, 29255.707442925297, 29544.282711299606, 29934.70065299319, 1108.3294606762954, 1125.774845030997, 1133.9433028348549, 1159.996602938469, 1240.505191244548, 13596.864031359757, 13752.862471375358, 15030.699386012218, 15167.469138580096, 15477.761779057648, 623387.0, 631773.0, 632472.0, 633381.0, 633760.0, 56926.0, 58909.705451472466, 58962.41037589569, 58963.705181473815, 59106.0, 1321.2468892731242, 1350.3045931345562, 1436.705475377566, 1449.9782503262459, 1489.3074720255133, 28007.719922800512, 28190.0, 28896.855515723128, 29252.793226858532, 29346.0, 47081.05837883292, 47194.29208561943, 47677.80805479891, 47761.044779103526, 47772.522274776806, 351953.0, 353686.0, 353789.0, 353933.0, 354526.0, 21934.780652193273, 22782.38002629719, 25602.9758809653, 26728.0, 26782.062627807933, 42376.36435453409, 43265.567344326155, 43465.56534434615, 43621.34567981419, 44128.89677757953, 35802.0, 36035.63964360323, 36092.458613120296, 36846.0, 36954.44568331531, 35859.282814343045, 36118.0, 37129.0, 37732.62267377291, 38009.619903801715, 26749.0, 33747.83126084354, 34068.829655851565, 34138.0, 34590.96227113191, 25119.729645960597, 30798.84600576983, 32022.758406912224, 32267.838660806545, 32316.86890958805, 23744.643830342906, 23986.920588573907, 23988.52022959496, 24348.391290217885, 24462.0], "value": 18116.831675297944, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.78202495340594, 394.5147468613605, 401.6706300833318, 408.21622484829123, 416.26113648274327, 17448.56378590536, 20302.796972030275, 21512.677309840365, 21519.462013449673, 21524.354269371925, 12112.9703975162, 12446.626601201955, 12452.626421207355, 12686.61940141795, 19554.51113722154, 5351.277577527042, 5539.639923404986, 5562.110062390018, 5567.944320556783, 5586.86032849178, 3922.2547715934024, 3948.644621984021, 4153.8961525961795, 6143.201383820097, 6169.722362493699, 5331.893362132755, 5746.477183546363, 6037.667928263943, 6161.322254551996, 6176.72204750785, 5413.891722165555, 6151.600145990541, 6165.969170154143, 6167.814965551041, 6169.907451388232, 3778.3199024175638, 5487.533559647435, 5855.590108692393, 5883.205767221413, 5885.0, 13852.584422467342, 13955.0, 17866.0, 24647.876760616262, 24672.766361681843, 2208.8895555222175, 2243.069126312578, 2310.1567927706265, 2369.3721163891582, 2508.6989561252767, 9793.608255669764, 9995.350302230332, 10093.343932644355, 10287.485625718758, 10484.842727359095, 1736.6222399045132, 1784.5717027913338, 1812.2026308424252, 1812.5378028602622, 1896.2794138227523, 118629.0, 124172.27483175609, 124887.0, 125901.37049314786, 127637.0, 10168.796624067478, 11234.550617975354, 11537.88462115368, 11929.463174157183, 12001.39993000364, 15393.692126157413, 15461.381544738084, 15461.768073478906, 15488.0, 15510.689786204213, 8704.26013788835, 8761.518116503654, 8795.296376289882, 8813.823723525493, 8935.597898094602, 8547.786305342292, 8556.957215214008, 8573.871391929126, 8710.695125670698, 8720.78198045054, 4650.209464391061, 4679.22792739201, 4701.78841952113, 4709.505501922249, 4759.881002974884, 1696.414736915762, 1786.7051936430344, 1828.8207874640432, 1848.8983105929035, 1966.9803301966797, 824.3734761581242, 939.4645052320249, 942.0626476655634, 948.3551185193996, 969.5782334684435, 19368.93470859088, 19992.0, 20097.296594619118, 20533.897330513253, 20754.06606702702, 946.5598496699068, 961.7980224153006, 968.2883080935507, 987.4717026390847, 1028.5114570579065, 9054.411463254868, 10200.387976721273, 10721.946390267998, 11160.274582152297, 11247.606333778442, 561624.0, 568383.0, 570364.0, 612929.0, 617977.0, 130024.0, 132385.0, 135877.0, 136927.0, 139373.30313348369, 1016.5679586175846, 1041.2971244409994, 1060.8143574874366, 1062.7768168684509, 1065.7016035510069, 18317.633647327246, 18371.357002504847, 18410.26358945681, 18438.89366638006, 18576.349827756505, 50980.490195097576, 51827.0, 52047.0, 52326.0, 52654.0, 71986.64006679933, 77400.61299693465, 78694.60652696699, 78867.21132788828, 81272.5936370338, 7048.118985126859, 7539.246075392417, 7567.508111972704, 7605.011348524657, 7896.565688887166, 12568.057395695543, 13075.673108171992, 13095.476180952655, 13270.933645331712, 13382.13016153947, 11042.282251653938, 11114.610988615359, 11270.492827822603, 11301.830472542753, 11377.374244416636, 11060.446977651247, 11201.66395008151, 11289.927456891583, 11298.152638552307, 11391.202615817145, 11088.889111109109, 11298.152638551977, 11430.1998860079, 11709.063274938155, 11781.52873885035, 7522.210167932507, 7593.658285377061, 7753.263439973193, 7773.339266162213, 7916.0, 10760.946195268974, 11096.167787415814, 11186.301753263811, 11202.258004996747, 11385.886141138482], "value": 9365.812827659383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.3192067807445, 1593.9760903586448, 1607.7427611582148, 1881.7835948865884, 2000.739903812504, 7970.60146992651, 8671.17623825737, 8885.644574217024, 8892.37753357266, 8919.286457083434, 8393.748187554384, 8709.825803483927, 8714.128587141282, 8715.564221788902, 8720.34597405194, 2440.0239904038394, 2475.232677869866, 2477.7398373170827, 2479.1942618648923, 2479.2438306316567, 2411.1922505960524, 2474.9752502475017, 2475.616279476684, 2477.34350397144, 2480.8015358771345, 2434.1358817619757, 2464.617984212441, 2477.6283557466345, 2483.3915690655726, 2485.465624890648, 2410.758924107593, 2435.2207293666033, 2442.9617412599664, 2449.7182823975113, 2464.2114523352534, 2393.1265088242667, 2426.9757302426924, 2442.9877850610633, 2443.3402981194977, 2455.091616102036, 8573.957130214372, 8712.825743485158, 8751.562421878943, 8809.075047120024, 8865.645374185026, 5286.841394758125, 5454.945450545483, 5465.699386533739, 5488.396276409591, 5488.835334939959, 3448.189675426298, 3572.7499075064757, 3654.9086272843124, 3664.633536646341, 3677.9517837416206, 1021.5249908792373, 1032.8967103289685, 1037.444966942682, 1044.6709286574705, 1046.712154157605, 10750.892491075145, 11513.194076414655, 11528.42357882111, 11536.365499897502, 11542.36516991565, 4471.776411179428, 4505.81976720934, 4715.552022557851, 4744.4069491313585, 4747.121782470254, 9230.307726920508, 9247.352685312098, 9262.16640502358, 9264.7683807904, 9287.328280909502, 5330.307060082242, 5331.253624492574, 5347.385050719217, 5363.195520671852, 5403.054465468527, 4445.310976798602, 4482.9775851121185, 4832.710037397767, 4874.025194961022, 5054.292399064134, 3830.540335159799, 3837.4052021936645, 3924.823382947717, 3926.411038344214, 3937.4487571739405, 1204.27141579345, 1217.9269243845397, 1223.174357308813, 1230.1880758699215, 1238.7708273969345, 669.4242951062083, 798.5683593457934, 813.2193094629104, 869.2003356911656, 988.7033889833021, 5782.306123265235, 5796.88406231873, 6006.939930600725, 6054.455099041107, 6067.423594758491, 958.3243813111878, 970.5486948568949, 980.6959842448864, 994.2046362909643, 1018.1193267823428, 3364.9327013459592, 3895.8441662333757, 4042.130941847517, 4058.859962837889, 4070.2063097695664, 9296.72109836706, 10399.116075133546, 10476.0, 10958.0, 10961.342319460859, 10811.945940270249, 10881.347119172875, 10887.891121088845, 10895.509702063426, 10905.127589792797, 8227.629756660845, 8307.6676932922, 8361.122082181406, 8426.241638252464, 8427.662893484192, 5620.100783874561, 5862.853428664317, 5911.0, 5925.4370834770625, 5952.8809423812145, 9554.28342874301, 9616.855747163938, 9816.950915245377, 9923.057309555581, 9930.05664461875, 9897.50512474359, 10025.699229023141, 10046.799064018825, 10128.544215510467, 10139.695809125738, 7463.179050304354, 7572.3942084632, 7603.619819009138, 7616.466847320856, 7627.771166865003, 8082.0, 8232.958835205785, 8240.546769927712, 8367.330613551023, 8395.412321137463, 7248.637568121468, 7412.332890039922, 7414.777556673308, 7494.737684181027, 7573.2048134945035, 7346.0, 7380.18817930038, 7432.851342973218, 7522.435817313614, 7589.6584653689615, 7061.2938706131035, 7144.67848946809, 7152.320529549685, 7163.677634506564, 7180.461465390013, 4797.808087676453, 4935.851924442272, 4982.327385803015, 5038.647294689336, 5215.139501982282, 4954.65317427791, 5001.4998500149695, 5091.567216786615, 5142.074426603247, 5155.639105262596], "value": 4607.292525984861, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.65857068669357, 324.40471734367435, 327.65923439622793, 331.70975396528024, 337.09153830426976, 5453.291072160619, 6024.5782795204295, 6050.304215015274, 6093.573449858512, 6110.602810817294, 4891.926621100686, 5901.675407852566, 5965.761369545213, 5967.88064238716, 6018.8796224075495, 4251.4685664291965, 4307.978460107695, 4392.34114882767, 4475.865724028268, 4552.499225085255, 4449.7997590108525, 4464.6874718769695, 4476.664250181233, 4490.326451032339, 4491.39366185564, 3877.6510114089724, 4067.3085575452096, 4486.0, 4492.213862574036, 4504.797284122206, 4252.957470425303, 4367.667861302301, 4372.360364863176, 4520.4575450946095, 4537.9773101134615, 3447.4311738563106, 3828.3300422425964, 3884.6892248620043, 3917.314469967744, 3921.392184211452, 5530.474604912567, 5561.499465048165, 5824.155497452888, 5854.736536855852, 5858.297004359461, 4508.2868509966, 4828.420589529243, 4976.676516026447, 5126.948730512684, 5178.016176926372, 6326.4938804895955, 6361.0, 6368.0, 6380.298167201604, 6384.648844313561, 3507.088157079152, 4007.979960100181, 4222.387753775716, 4225.661947044229, 4234.195502854448, 5251.030863426216, 5865.85335366615, 6731.495137864631, 6762.898556521656, 6773.695183716744, 3650.3976843821, 4246.808893599796, 4269.124829409963, 4273.63674087706, 4278.743275403485, 3875.379939209713, 4289.635380992589, 4302.526722060571, 4362.323839804835, 4370.8033138508845, 4891.657583969088, 5065.8733531662, 5126.564242039394, 5163.302954101148, 5164.354455693038, 5676.318841739017, 6415.486761059104, 6417.550771445954, 6428.77853207889, 6441.871162576722, 1430.1990885104374, 1468.6475245940896, 1493.4772829509584, 1499.4601943300404, 1509.3208056374676, 903.7333986474006, 950.7242899559188, 959.3764053365369, 974.1086905481546, 978.4765150644513, 4802.399700037496, 5729.799457019068, 5853.09277062056, 6043.7884674036195, 6095.420935011167, 5592.86017849557, 6614.371634694697, 6639.402453779183, 6675.165604299463, 6704.128463299838, 5857.970710146422, 6010.429009244115, 6034.426729460694, 6037.667928263988, 6044.607100538451, 3459.9654003460146, 3478.956313106058, 3487.8081705505933, 3520.2431477232008, 3527.400341941876, 6609.173853268341, 6904.930950690529, 6979.1973922999505, 6996.19543752475, 7001.229864714877, 6407.583507072025, 6739.326067393222, 6767.830804229934, 6808.2510923798345, 6816.4546836252985, 5803.158542011384, 6417.614943103429, 6920.826979325457, 6932.7226910923, 6966.164060312795, 5003.849884503471, 5335.573154147736, 6620.536562440583, 6624.362945937766, 6700.43046341047, 5519.806806761744, 5956.642601443928, 6422.678866056585, 6555.049517819984, 6555.410013098844, 6023.765128148631, 6591.835204119935, 6657.234418041793, 6887.276835932155, 6890.380760521373, 4092.877213683594, 4252.87241382759, 4294.355846622907, 4303.1393721255245, 4311.461067366579, 6302.558820882494, 6548.934510654833, 6675.59946403198, 6694.4644428444635, 6695.866082678222, 5361.812336568201, 5498.95519851227, 6370.331115232834, 6449.580777249464, 6503.0, 5333.759980800951, 6234.82143300581, 6415.390537898892, 6439.162908821823, 6441.581297215666, 5367.5169234769055, 5529.30883639545, 5820.894030134261, 6189.535784816067, 6318.399752023551, 6272.937270627235, 6428.614283143026, 6448.0, 6474.870502590016, 6511.934880651323, 5248.737563121905, 5636.2744077451025, 5773.84523095391, 6316.968415157895, 6395.744170233324], "value": 4603.200211066368, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.3705221277037, 647.8477557773925, 657.4346062386348, 744.8175197076717, 774.1909704358944, 14957.775633365494, 15268.236588170603, 15314.387424503035, 15371.538853834389, 15431.845681543182, 13651.385687644055, 14086.366113524891, 14135.293235338218, 14138.858611413909, 14275.428982840675, 930.8045310484806, 933.6545478173051, 946.8921362006434, 948.9003654616234, 951.3720944176845, 909.295296145486, 921.8156368726249, 922.903095175007, 922.9723108306762, 929.7675581104724, 887.5695287785419, 970.9320347575673, 976.1263669016226, 976.8046390721848, 980.5734505490099, 971.3880255439063, 972.1008067537499, 972.2270794718181, 972.4651441707033, 981.0, 724.2974314914577, 725.9782206533813, 726.2048057377164, 727.1274470635205, 728.0171768113058, 13290.20258784476, 13508.257045862474, 13524.729505409936, 13583.320833958362, 13897.374618142208, 11310.943445282803, 11458.942705286503, 11558.30650160993, 11598.826017609743, 12026.879731202664, 9480.241580673599, 9577.377470464398, 9858.753531161707, 9985.500724963722, 10112.89887101127, 3469.4969229461585, 3491.2319289756215, 3561.5013898054294, 3565.7682250653884, 3654.926901461956, 58599.41400585982, 62625.0, 67139.66430167867, 77876.83184752177, 81922.59038704827, 10056.899431005742, 10068.899311006942, 10121.392716437038, 10381.740456488647, 10485.056344928993, 21954.560908781736, 21987.780122198572, 22025.0, 22032.33902982913, 22070.448238794157, 6500.902486462707, 7527.585982771, 7555.09338879327, 7685.923140768521, 7698.92301076982, 4121.9381709274385, 4148.57023730931, 4253.680973926967, 4275.230458517497, 4279.807408666617, 3447.844846981892, 3571.714262858965, 3571.910702232465, 3573.4997100405963, 3574.088607405147, 634.7238951056305, 643.029026170486, 646.1664452855857, 650.5413683353224, 651.5146216068964, 518.7043385270359, 549.6177114556892, 569.291232415637, 577.177522031104, 596.2546816479401, 7097.183823860219, 7606.733764318223, 7795.668075382066, 7846.5292082475235, 7910.248526389983, 496.20607028754426, 505.72690746996943, 535.2159086937655, 559.5663360895257, 562.1876388618489, 3235.482322828383, 3419.8803041893416, 3684.5762737285554, 3737.71967102463, 3790.045553908737, 70813.64593177, 72193.0, 72370.0, 72468.27531724615, 72994.63502682453, 67219.0, 67712.0, 68054.65972670105, 68119.0, 68218.65890670515, 48650.0, 58523.24430267099, 62731.0, 67301.0, 68178.97731534031, 6413.909635361906, 7784.766457006299, 7813.374930005472, 7947.483413578099, 8026.1171271158955, 35713.1071723209, 37554.248915021, 39056.804715976235, 39159.62941297041, 40257.39613905735, 55425.44574554203, 56286.0, 56749.71625141848, 56856.0, 57003.714981424826, 11043.282186657842, 11223.831642525205, 11255.099592032453, 11295.039921606756, 11571.942140289244, 11764.117691173025, 12091.516339346328, 12124.33316167584, 12243.32661703615, 12913.031522635652, 11405.429728513374, 11764.416308125485, 11932.761344772882, 11943.76112477763, 12053.698657533632, 8993.730188094367, 11103.555857765921, 11249.66251012471, 11555.364454954723, 11616.070714343, 11051.778964420506, 11522.481488333213, 11525.135614828754, 11758.647240582795, 12310.938445308075, 9292.674756383494, 9597.47213903242, 9719.590659354495, 9982.301238913205, 10089.142422894136, 8871.600777964877, 9605.711828645151, 9661.323707340418, 9698.46658433793, 9811.411315321104], "value": 6649.254699563442, "unit": "score"}], "name": "dromaeo_css", "value": 7172.901663929397, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 113.0, 127.0, 113.0, 113.0, 120.0, 112.0, 112.0, 112.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 148.0, 172.0, 123.0, 147.0, 141.0, 119.0, 199.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 188.0, 187.0, 184.0, 199.0, 250.0, 182.0, 184.0, 183.0, 184.0], "value": 192.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 87.0, 93.0, 55.0, 59.0, 57.0, 79.0, 83.0, 55.0], "value": 72.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 137.0, 77.0, 77.0, 77.0, 128.0, 79.0, 76.0, 125.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 131.0, 105.0, 84.0, 87.0, 85.0, 97.0, 131.0, 134.0, 84.0], "value": 104.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 93.0, 95.0, 93.0, 93.0, 93.0, 93.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 86.0, 86.0, 85.0, 84.0, 84.0, 83.0, 80.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 59.0, 59.0, 58.0, 77.0, 60.0, 56.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 78.0, 73.0, 69.0, 68.0, 67.0, 67.0, 67.0, 69.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 87.0, 84.0, 102.0, 104.0, 114.0, 87.0, 84.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 145.0, 148.0, 164.0, 127.0, 166.0, 170.0, 160.0, 183.0, 146.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 173.0, 170.0, 176.0, 172.0, 168.0, 201.0, 222.0, 179.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 68.0, 67.0, 67.0, 66.0, 70.0, 69.0, 68.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1529.5, "alertThreshold": 2.0}]} 05:53:13 INFO - Return code: 0 05:53:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:53:13 ERROR - # TBPL SUCCESS # 05:53:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:13 INFO - 2016-04-13 05:53:13.249 screenresolution[2506:21371] starting screenresolution argv=screenresolution get 05:53:13 INFO - 2016-04-13 05:53:13.251 screenresolution[2506:21371] Display 0: 1600x1200x32@60 05:53:13 INFO - 2016-04-13 05:53:13.257 screenresolution[2507:21374] starting screenresolution argv=screenresolution list 05:53:13 INFO - Available Modes on Display 0 05:53:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:13 INFO - Intel Iris: 05:53:13 INFO - Chipset Model: Intel Iris 05:53:13 INFO - Type: GPU 05:53:13 INFO - Bus: Built-In 05:53:13 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:13 INFO - Vendor: Intel (0x8086) 05:53:13 INFO - Device ID: 0x0a2e 05:53:13 INFO - Revision ID: 0x0009 05:53:13 INFO - Displays: 05:53:13 INFO - Display: 05:53:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:13 INFO - Display Serial Number: 1600x1200 60 05:53:13 INFO - Main Display: Yes 05:53:13 INFO - Mirror: Off 05:53:13 INFO - Online: Yes 05:53:13 INFO - Rotation: Supported 05:53:13 INFO - Return code: 0 05:53:13 INFO - Running post-action listener: _resource_record_post_action 05:53:13 INFO - Running post-run listener: _resource_record_post_run 05:53:14 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 766464; Write bytes: 691897344; Read time: 10; Write time: 1847 05:53:14 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 378565120; Write bytes: 373874688; Read time: 28295; Write time: 675 05:53:14 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 766464; Write bytes: 295052288; Read time: 10; Write time: 1124 05:53:14 INFO - Running post-run listener: _upload_blobber_files 05:53:14 INFO - Blob upload gear active. 05:53:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:14 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:53:14 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:53:14 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:53:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:53:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:16 INFO - (blobuploader) - INFO - Done attempting. 05:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:17 INFO - (blobuploader) - INFO - Done attempting. 05:53:17 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:17 INFO - Return code: 0 05:53:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56c4dda856cf3eca2976237d45542c0e49eac0c093c21e070858c993c2b1e97db8b27f74e6707840cb75b2ec67f42802f8b20e235a67bd76ea9265d8f07b4b50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6627901227f535d738278c736cf2fc1911033d2a8d035b01fd2d861cbd4c3fde71545a1c628be72043968959fbe0b4c483b0d09cd67bda2fe83f1c092d73607f"} 05:53:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:17 INFO - Contents: 05:53:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56c4dda856cf3eca2976237d45542c0e49eac0c093c21e070858c993c2b1e97db8b27f74e6707840cb75b2ec67f42802f8b20e235a67bd76ea9265d8f07b4b50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6627901227f535d738278c736cf2fc1911033d2a8d035b01fd2d861cbd4c3fde71545a1c628be72043968959fbe0b4c483b0d09cd67bda2fe83f1c092d73607f"} 05:53:17 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:17 INFO - Copying logs to upload dir... 05:53:17 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.548837 ========= master_lag: 1.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-13 05:53:18.795419) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 05:53:18.799369) ========= 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.Bfv7dam020/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.kxcLEeGgL3/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56c4dda856cf3eca2976237d45542c0e49eac0c093c21e070858c993c2b1e97db8b27f74e6707840cb75b2ec67f42802f8b20e235a67bd76ea9265d8f07b4b50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6627901227f535d738278c736cf2fc1911033d2a8d035b01fd2d861cbd4c3fde71545a1c628be72043968959fbe0b4c483b0d09cd67bda2fe83f1c092d73607f"} build_url:https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011024 build_url: 'https://queue.taskcluster.net/v1/task/fmyeyDlYTgi7-GMPf0-bzA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56c4dda856cf3eca2976237d45542c0e49eac0c093c21e070858c993c2b1e97db8b27f74e6707840cb75b2ec67f42802f8b20e235a67bd76ea9265d8f07b4b50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6627901227f535d738278c736cf2fc1911033d2a8d035b01fd2d861cbd4c3fde71545a1c628be72043968959fbe0b4c483b0d09cd67bda2fe83f1c092d73607f"}' ========= master_lag: 0.18 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 05:53:18.993231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:53:18.993628) ========= 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.Bfv7dam020/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.kxcLEeGgL3/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.005376 ========= master_lag: 0.45 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:53:19.450597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 05:53:19.452967) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 05:53:19.888216) ========= ========= Total master_lag: 3.32 =========