builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0044 starttime: 1457527967.37 results: success (0) buildid: 20160309024915 builduid: 60e1e65d92704fc2b514a91b055551e1 revision: 7436297ba12f1d027e8d4ce0fb70eb4fa0acee94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 04:52:47.371320) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 04:52:47.371709) ========= ========= Started set props: basedir (results: 0, elapsed: 7 secs) (at 2016-03-09 04:52:47.371990) ========= 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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.005566 basedir: '/builds/slave/test' ========= master_lag: 7.86 ========= ========= Finished set props: basedir (results: 0, elapsed: 7 secs) (at 2016-03-09 04:52:55.233978) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-09 04:52:55.234302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-09 04:52:56.345612) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 04:52:56.345891) ========= 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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.005691 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 04:52:56.395243) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 04:52:56.395505) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 04:52:56.395854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 04:52:56.396129) ========= 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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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-03-09 04:52:56-- 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% 48.4M=0s 2016-03-09 04:52:56 (48.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175836 ========= master_lag: 1.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 04:52:57.887881) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-03-09 04:52:57.888221) ========= 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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.025470 ========= master_lag: 2.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-03-09 04:53:00.009840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 04:53:00.010213) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7436297ba12f1d027e8d4ce0fb70eb4fa0acee94 --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 7436297ba12f1d027e8d4ce0fb70eb4fa0acee94 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1ON4CV5u8o/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.tMfQ34dDCl/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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-03-09 04:53:00,093 truncating revision to first 12 chars 2016-03-09 04:53:00,093 Setting DEBUG logging. 2016-03-09 04:53:00,093 attempt 1/10 2016-03-09 04:53:00,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7436297ba12f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 04:53:01,783 unpacking tar archive at: fx-team-7436297ba12f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.936784 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 04:53:01.974200) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 04:53:01.974529) ========= echo 7436297ba12f1d027e8d4ce0fb70eb4fa0acee94 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7436297ba12f1d027e8d4ce0fb70eb4fa0acee94'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1ON4CV5u8o/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.tMfQ34dDCl/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 7436297ba12f1d027e8d4ce0fb70eb4fa0acee94 program finished with exit code 0 elapsedTime=0.005404 script_repo_revision: '7436297ba12f1d027e8d4ce0fb70eb4fa0acee94' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 04:53:02.030397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 04:53:02.030730) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 04:53:02.047140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-09 04:53:02.047489) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1ON4CV5u8o/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.tMfQ34dDCl/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 04:53:02 INFO - MultiFileLogger online at 20160309 04:53:02 in /builds/slave/test 04:53:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:53:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:53:02 INFO - {'append_to_log': False, 04:53:02 INFO - 'base_work_dir': '/builds/slave/test', 04:53:02 INFO - 'blob_upload_branch': 'Fx-Team', 04:53:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:53:02 INFO - 'branch': 'Fx-Team', 04:53:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:53:02 INFO - 'config_files': ('talos/mac_config.py',), 04:53:02 INFO - 'default_actions': ('clobber', 04:53:02 INFO - 'read-buildbot-config', 04:53:02 INFO - 'download-and-extract', 04:53:02 INFO - 'populate-webroot', 04:53:02 INFO - 'create-virtualenv', 04:53:02 INFO - 'install', 04:53:02 INFO - 'run-tests'), 04:53:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:53:02 INFO - 'download_minidump_stackwalk': True, 04:53:02 INFO - 'download_symbols': 'ondemand', 04:53:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:53:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:53:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:53:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:53:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:53:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:53:02 INFO - 'installer_path': 'installer.exe', 04:53:02 INFO - 'log_level': 'info', 04:53:02 INFO - 'log_name': 'talos', 04:53:02 INFO - 'log_to_console': True, 04:53:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:53:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:53:02 INFO - 'opt_config_files': (), 04:53:02 INFO - 'pip_index': False, 04:53:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:53:02 INFO - 'cmd': ('bash', 04:53:02 INFO - '-c', 04:53:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:53:02 INFO - 'enabled': True, 04:53:02 INFO - 'halt_on_failure': False, 04:53:02 INFO - 'name': 'check_screen_resolution'},), 04:53:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:53:02 INFO - 'cmd': ('bash', 04:53:02 INFO - '-c', 04:53:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:53:02 INFO - 'enabled': True, 04:53:02 INFO - 'halt_on_failure': False, 04:53:02 INFO - 'name': 'check_screen_resolution'},), 04:53:02 INFO - 'run_cmd_checks_enabled': True, 04:53:02 INFO - 'sps_profile': False, 04:53:02 INFO - 'sps_profile_interval': 0, 04:53:02 INFO - 'suite': 'dromaeojs-e10s', 04:53:02 INFO - 'system_bits': '32', 04:53:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:53:02 INFO - 'title': 't-yosemite-r7-0044', 04:53:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:53:02 INFO - 'use_talos_json': True, 04:53:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:53:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:53:02 INFO - 'work_dir': 'build'} 04:53:02 INFO - ##### 04:53:02 INFO - ##### Running clobber step. 04:53:02 INFO - ##### 04:53:02 INFO - Running pre-action listener: _resource_record_pre_action 04:53:02 INFO - Running main action method: clobber 04:53:02 INFO - rmtree: /builds/slave/test/build 04:53:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:53:04 INFO - Running post-action listener: _resource_record_post_action 04:53:04 INFO - ##### 04:53:04 INFO - ##### Running read-buildbot-config step. 04:53:04 INFO - ##### 04:53:04 INFO - Running pre-action listener: _resource_record_pre_action 04:53:04 INFO - Running main action method: read_buildbot_config 04:53:04 INFO - Using buildbot properties: 04:53:04 INFO - { 04:53:04 INFO - "project": "", 04:53:04 INFO - "product": "firefox", 04:53:04 INFO - "script_repo_revision": "production", 04:53:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:53:04 INFO - "repository": "", 04:53:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:53:04 INFO - "buildid": "20160309024915", 04:53:04 INFO - "pgo_build": "False", 04:53:04 INFO - "basedir": "/builds/slave/test", 04:53:04 INFO - "buildnumber": 607, 04:53:04 INFO - "slavename": "t-yosemite-r7-0044", 04:53:04 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:53:04 INFO - "platform": "yosemite_r7", 04:53:04 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 04:53:04 INFO - "branch": "fx-team", 04:53:04 INFO - "repo_path": "integration/fx-team", 04:53:04 INFO - "revision": "7436297ba12f1d027e8d4ce0fb70eb4fa0acee94", 04:53:04 INFO - "stage_platform": "macosx64", 04:53:04 INFO - "builduid": "60e1e65d92704fc2b514a91b055551e1", 04:53:04 INFO - "slavebuilddir": "test" 04:53:04 INFO - } 04:53:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:53:04 INFO - Running post-action listener: _resource_record_post_action 04:53:04 INFO - ##### 04:53:04 INFO - ##### Running download-and-extract step. 04:53:04 INFO - ##### 04:53:04 INFO - Running pre-action listener: _resource_record_pre_action 04:53:04 INFO - Running main action method: download_and_extract 04:53:04 INFO - mkdir: /builds/slave/test/build/tests 04:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:04 INFO - https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:53:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:53:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:53:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/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 04:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/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 04:53:05 INFO - Downloaded 1199 bytes. 04:53:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:53:05 INFO - Using the following test package requirements: 04:53:05 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:53:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:05 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:53:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:05 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:53:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:05 INFO - u'jsshell-mac.zip'], 04:53:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:05 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:53:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:53:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:05 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:53:05 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:05 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:53:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:05 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:53:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:53:05 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:53:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:05 INFO - https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:53:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:53:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:53:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/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 04:53:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/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 04:53:06 INFO - Downloaded 17865933 bytes. 04:53:06 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'] 04:53:06 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 04:53:09 INFO - Return code: 0 04:53:09 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 04:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:53:09 INFO - https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:53:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:53:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:53:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/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 04:53:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/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 04:53:10 INFO - Downloaded 17865933 bytes. 04:53:10 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'] 04:53:10 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 04:53:14 INFO - Return code: 0 04:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:14 INFO - https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:53:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:53:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:53:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/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 04:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/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 04:53:15 INFO - Downloaded 10845161 bytes. 04:53:15 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'] 04:53:15 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 04:53:15 INFO - Return code: 0 04:53:15 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')]} 04:53:15 INFO - https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:53:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:53:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:53:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXJ84ziQ7qtWXEgYC047g/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 04:53:18 INFO - Downloaded 110926608 bytes. 04:53:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:53:18 INFO - mkdir: /builds/slave/test/properties 04:53:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:18 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:18 INFO - Contents: 04:53:18 INFO - build_url:https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:53:19 INFO - Running post-action listener: _resource_record_post_action 04:53:19 INFO - Running post-action listener: set_extra_try_arguments 04:53:19 INFO - ##### 04:53:19 INFO - ##### Running populate-webroot step. 04:53:19 INFO - ##### 04:53:19 INFO - Running pre-action listener: _resource_record_pre_action 04:53:19 INFO - Running main action method: populate_webroot 04:53:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:19 INFO - '--tppagecycles', 04:53:19 INFO - '7'], 04:53:19 INFO - 'tests': ['tsvgm']}}, 04:53:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:53:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:53:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:53:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:53:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:19 INFO - 'talos_options': ['--e10s'], 04:53:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:19 INFO - 'tests': ['damp', 'tps']}, 04:53:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:19 INFO - 'talos_options': ['--e10s'], 04:53:19 INFO - 'tests': ['damp', 'tps']}, 04:53:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:53:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:19 INFO - 'other': {'tests': ['a11yr', 04:53:19 INFO - 'ts_paint', 04:53:19 INFO - 'tpaint', 04:53:19 INFO - 'sessionrestore', 04:53:19 INFO - 'sessionrestore_no_auto_restore', 04:53:19 INFO - 'tabpaint']}, 04:53:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:53:19 INFO - 'tests': ['a11yr', 04:53:19 INFO - 'ts_paint', 04:53:19 INFO - 'tpaint', 04:53:19 INFO - 'sessionrestore', 04:53:19 INFO - 'sessionrestore_no_auto_restore', 04:53:19 INFO - 'tabpaint']}, 04:53:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:53:19 INFO - 'tests': ['a11yr', 04:53:19 INFO - 'ts_paint', 04:53:19 INFO - 'tpaint', 04:53:19 INFO - 'sessionrestore', 04:53:19 INFO - 'sessionrestore_no_auto_restore', 04:53:19 INFO - 'tabpaint']}, 04:53:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:53:19 INFO - 'tests': ['a11yr', 04:53:19 INFO - 'ts_paint', 04:53:19 INFO - 'tpaint', 04:53:19 INFO - 'sessionrestore', 04:53:19 INFO - 'sessionrestore_no_auto_restore', 04:53:19 INFO - 'tabpaint']}, 04:53:19 INFO - 'other_l64': {'tests': ['a11yr', 04:53:19 INFO - 'ts_paint', 04:53:19 INFO - 'tpaint', 04:53:19 INFO - 'sessionrestore', 04:53:19 INFO - 'sessionrestore_no_auto_restore', 04:53:19 INFO - 'tabpaint']}, 04:53:19 INFO - 'other_nol64': {'tests': ['a11yr', 04:53:19 INFO - 'ts_paint', 04:53:19 INFO - 'tpaint', 04:53:19 INFO - 'sessionrestore', 04:53:19 INFO - 'sessionrestore_no_auto_restore', 04:53:19 INFO - 'tabpaint']}, 04:53:19 INFO - 'svgr': {'tests': ['tsvgx', 04:53:19 INFO - 'tsvgr_opacity', 04:53:19 INFO - 'tart', 04:53:19 INFO - 'tscrollx', 04:53:19 INFO - 'cart']}, 04:53:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:53:19 INFO - 'tests': ['tsvgx', 04:53:19 INFO - 'tsvgr_opacity', 04:53:19 INFO - 'tart', 04:53:19 INFO - 'tscrollx', 04:53:19 INFO - 'cart']}, 04:53:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:19 INFO - 'tests': ['tp5o']}, 04:53:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:19 INFO - 'talos_options': ['--e10s'], 04:53:19 INFO - 'tests': ['tp5o']}, 04:53:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:19 INFO - 'talos_options': ['--xperf_path', 04:53:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:19 INFO - 'tests': ['tp5n']}, 04:53:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:53:19 INFO - 'talos_options': ['--e10s', 04:53:19 INFO - '--xperf_path', 04:53:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:19 INFO - 'tests': ['tp5n']}}, 04:53:19 INFO - 'talos.zip': {'path': '', 04:53:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:19 INFO - Running post-action listener: _resource_record_post_action 04:53:19 INFO - ##### 04:53:19 INFO - ##### Running create-virtualenv step. 04:53:19 INFO - ##### 04:53:19 INFO - Running pre-action listener: _resource_record_pre_action 04:53:19 INFO - Running main action method: create_virtualenv 04:53:19 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:19 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 04:53:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:19 INFO - Using real prefix '/tools/python27' 04:53:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:23 INFO - Installing pip.................done. 04:53:23 INFO - Return code: 0 04:53:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10300fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030164c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c68c987c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb3d30>, '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 0x102cd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaab20>, '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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 04:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:53:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ON4CV5u8o/Render', 04:53:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:23 INFO - 'HOME': '/Users/cltbld', 04:53:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:23 INFO - 'LOGNAME': 'cltbld', 04:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:23 INFO - 'MOZ_NO_REMOTE': '1', 04:53:23 INFO - 'NO_EM_RESTART': '1', 04:53:23 INFO - 'PAGER': '/bin/cat', 04:53:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:23 INFO - 'PWD': '/builds/slave/test', 04:53:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:23 INFO - 'SHELL': '/bin/bash', 04:53:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tMfQ34dDCl/Listeners', 04:53:23 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 04:53:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:23 INFO - 'USER': 'cltbld', 04:53:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:23 INFO - 'XPC_FLAGS': '0x0', 04:53:23 INFO - 'XPC_SERVICE_NAME': '0', 04:53:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:23 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 04:53:23 INFO - Cleaning up... 04:53:23 INFO - Return code: 0 04:53:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10300fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030164c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c68c987c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb3d30>, '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 0x102cd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaab20>, '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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 04:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:53:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ON4CV5u8o/Render', 04:53:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:23 INFO - 'HOME': '/Users/cltbld', 04:53:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:23 INFO - 'LOGNAME': 'cltbld', 04:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:23 INFO - 'MOZ_NO_REMOTE': '1', 04:53:23 INFO - 'NO_EM_RESTART': '1', 04:53:23 INFO - 'PAGER': '/bin/cat', 04:53:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:23 INFO - 'PWD': '/builds/slave/test', 04:53:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:23 INFO - 'SHELL': '/bin/bash', 04:53:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tMfQ34dDCl/Listeners', 04:53:23 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 04:53:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:23 INFO - 'USER': 'cltbld', 04:53:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:23 INFO - 'XPC_FLAGS': '0x0', 04:53:23 INFO - 'XPC_SERVICE_NAME': '0', 04:53:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:23 INFO - Downloading/unpacking psutil>=0.7.1 04:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:26 INFO - Installing collected packages: psutil 04:53:26 INFO - Running setup.py install for psutil 04:53:26 INFO - building 'psutil._psutil_osx' extension 04:53:26 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 04:53:27 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 04:53:27 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 04:53:27 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 04:53:27 INFO - building 'psutil._psutil_posix' extension 04:53:27 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 04:53:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:53:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:53:27 INFO - ^ 04:53:27 INFO - 1 warning generated. 04:53:27 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 04:53:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:27 INFO - Successfully installed psutil 04:53:27 INFO - Cleaning up... 04:53:27 INFO - Return code: 0 04:53:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:53:27 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')]} 04:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:27 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')]} 04:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:27 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 0x10300fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030164c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c68c987c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb3d30>, '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 0x102cd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaab20>, '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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 04:53:27 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 04:53:27 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 04:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ON4CV5u8o/Render', 04:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:27 INFO - 'HOME': '/Users/cltbld', 04:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:27 INFO - 'LOGNAME': 'cltbld', 04:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:27 INFO - 'MOZ_NO_REMOTE': '1', 04:53:27 INFO - 'NO_EM_RESTART': '1', 04:53:27 INFO - 'PAGER': '/bin/cat', 04:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:27 INFO - 'PWD': '/builds/slave/test', 04:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:27 INFO - 'SHELL': '/bin/bash', 04:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tMfQ34dDCl/Listeners', 04:53:27 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 04:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:27 INFO - 'USER': 'cltbld', 04:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:27 INFO - 'XPC_FLAGS': '0x0', 04:53:27 INFO - 'XPC_SERVICE_NAME': '0', 04:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:53:28 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 04:53:28 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 04:53:28 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 04:53:28 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 04:53:28 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 04:53:28 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 04:53:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:53:30 INFO - Installing collected packages: mozsystemmonitor 04:53:30 INFO - Running setup.py install for mozsystemmonitor 04:53:30 INFO - Successfully installed mozsystemmonitor 04:53:30 INFO - Cleaning up... 04:53:30 INFO - Return code: 0 04:53:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:30 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')]} 04:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:30 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')]} 04:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:30 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 0x10300fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030164c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c68c987c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb3d30>, '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 0x102cd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaab20>, '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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 04:53:30 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 04:53:30 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 04:53:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ON4CV5u8o/Render', 04:53:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:30 INFO - 'HOME': '/Users/cltbld', 04:53:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:30 INFO - 'LOGNAME': 'cltbld', 04:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:30 INFO - 'MOZ_NO_REMOTE': '1', 04:53:30 INFO - 'NO_EM_RESTART': '1', 04:53:30 INFO - 'PAGER': '/bin/cat', 04:53:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:30 INFO - 'PWD': '/builds/slave/test', 04:53:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:30 INFO - 'SHELL': '/bin/bash', 04:53:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tMfQ34dDCl/Listeners', 04:53:30 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 04:53:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:30 INFO - 'USER': 'cltbld', 04:53:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:30 INFO - 'XPC_FLAGS': '0x0', 04:53:30 INFO - 'XPC_SERVICE_NAME': '0', 04:53:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:31 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:35 INFO - Downloading docopt-0.6.1.tar.gz 04:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:35 INFO - Running setup.py install for blobuploader 04:53:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:35 INFO - Running setup.py install for requests 04:53:35 INFO - Running setup.py install for docopt 04:53:36 INFO - Successfully installed blobuploader requests docopt 04:53:36 INFO - Cleaning up... 04:53:36 INFO - Return code: 0 04:53:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:36 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 0x10300fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030164c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c68c987c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb3d30>, '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 0x102cd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaab20>, '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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 04:53:36 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 04:53:36 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 04:53:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ON4CV5u8o/Render', 04:53:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:36 INFO - 'HOME': '/Users/cltbld', 04:53:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:36 INFO - 'LOGNAME': 'cltbld', 04:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:36 INFO - 'MOZ_NO_REMOTE': '1', 04:53:36 INFO - 'NO_EM_RESTART': '1', 04:53:36 INFO - 'PAGER': '/bin/cat', 04:53:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:36 INFO - 'PWD': '/builds/slave/test', 04:53:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:36 INFO - 'SHELL': '/bin/bash', 04:53:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tMfQ34dDCl/Listeners', 04:53:36 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 04:53:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:36 INFO - 'USER': 'cltbld', 04:53:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:36 INFO - 'XPC_FLAGS': '0x0', 04:53:36 INFO - 'XPC_SERVICE_NAME': '0', 04:53:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-OOm6Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-_MQmo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-iKC7sH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-FEi0Wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-_pLx1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-Utdp_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:37 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-cNoAXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:37 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-j11rOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:37 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-_VMIQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:37 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-EfX2zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:37 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-D_Gie1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:37 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-cvb5oA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:37 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-FGHo67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:37 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-pLIYsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:37 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-wMg4qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:37 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-Z46ImV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:38 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-51NIIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:38 INFO - Running setup.py install for manifestparser 04:53:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:38 INFO - Running setup.py install for mozcrash 04:53:38 INFO - Running setup.py install for mozdebug 04:53:38 INFO - Running setup.py install for mozdevice 04:53:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:53:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:38 INFO - Running setup.py install for mozfile 04:53:38 INFO - Running setup.py install for mozhttpd 04:53:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:39 INFO - Running setup.py install for mozinfo 04:53:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:39 INFO - Running setup.py install for mozInstall 04:53:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:39 INFO - Running setup.py install for mozleak 04:53:39 INFO - Running setup.py install for mozlog 04:53:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:39 INFO - Running setup.py install for moznetwork 04:53:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:39 INFO - Running setup.py install for mozprocess 04:53:39 INFO - Running setup.py install for mozprofile 04:53:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:40 INFO - Running setup.py install for mozrunner 04:53:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:40 INFO - Running setup.py install for mozscreenshot 04:53:40 INFO - Running setup.py install for moztest 04:53:40 INFO - Running setup.py install for mozversion 04:53:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:40 INFO - Cleaning up... 04:53:40 INFO - Return code: 0 04:53:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:40 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 0x10300fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030164c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c68c987c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb3d30>, '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 0x102cd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaab20>, '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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 04:53:40 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 04:53:40 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 04:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ON4CV5u8o/Render', 04:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:40 INFO - 'HOME': '/Users/cltbld', 04:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:40 INFO - 'LOGNAME': 'cltbld', 04:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:40 INFO - 'MOZ_NO_REMOTE': '1', 04:53:40 INFO - 'NO_EM_RESTART': '1', 04:53:40 INFO - 'PAGER': '/bin/cat', 04:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:40 INFO - 'PWD': '/builds/slave/test', 04:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:40 INFO - 'SHELL': '/bin/bash', 04:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tMfQ34dDCl/Listeners', 04:53:40 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 04:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:40 INFO - 'USER': 'cltbld', 04:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:40 INFO - 'XPC_FLAGS': '0x0', 04:53:40 INFO - 'XPC_SERVICE_NAME': '0', 04:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:40 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-4Coxwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:41 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)) 04:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-Pzx6R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:41 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)) 04:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-OfKT4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:41 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)) 04:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-VuSlPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:41 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)) 04:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-UC5gjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:41 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)) 04:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-DMJCtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:41 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)) 04:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-NhgXCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:41 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)) 04:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-0US1KQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:41 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)) 04:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-wDlACA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:41 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)) 04:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:41 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-c3UZ1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:42 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)) 04:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-CnVkUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:42 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)) 04:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-5FiZNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:42 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)) 04:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-1qdp42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:42 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)) 04:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-psuWMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:42 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)) 04:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-xTGHz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:42 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)) 04:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-kTYBWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:42 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)) 04:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:42 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-sj7VdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53: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 04:53:45 INFO - Downloading blessings-1.6.tar.gz 04:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:45 INFO - Installing collected packages: blessings 04:53:45 INFO - Running setup.py install for blessings 04:53:45 INFO - Successfully installed blessings 04:53:45 INFO - Cleaning up... 04:53:45 INFO - Return code: 0 04:53:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:45 INFO - Reading from file tmpfile_stdout 04:53:45 INFO - Current package versions: 04:53:45 INFO - blessings == 1.6 04:53:45 INFO - blobuploader == 1.2.4 04:53:45 INFO - docopt == 0.6.1 04:53:45 INFO - manifestparser == 1.1 04:53:45 INFO - mozInstall == 1.12 04:53:45 INFO - mozcrash == 0.17 04:53:45 INFO - mozdebug == 0.1 04:53:45 INFO - mozdevice == 0.48 04:53:45 INFO - mozfile == 1.2 04:53:45 INFO - mozhttpd == 0.7 04:53:45 INFO - mozinfo == 0.9 04:53:45 INFO - mozleak == 0.1 04:53:45 INFO - mozlog == 3.1 04:53:45 INFO - moznetwork == 0.27 04:53:45 INFO - mozprocess == 0.22 04:53:45 INFO - mozprofile == 0.28 04:53:45 INFO - mozrunner == 6.11 04:53:45 INFO - mozscreenshot == 0.1 04:53:45 INFO - mozsystemmonitor == 0.0 04:53:45 INFO - moztest == 0.7 04:53:45 INFO - mozversion == 1.4 04:53:45 INFO - psutil == 3.1.1 04:53:45 INFO - requests == 1.2.3 04:53:45 INFO - wsgiref == 0.1.2 04:53:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:45 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')]} 04:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:45 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')]} 04:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:45 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 0x10300fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030164c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c68c987c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb3d30>, '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 0x102cd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaab20>, '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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 04:53:45 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 04:53:45 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 04:53:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ON4CV5u8o/Render', 04:53:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:45 INFO - 'HOME': '/Users/cltbld', 04:53:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:45 INFO - 'LOGNAME': 'cltbld', 04:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:45 INFO - 'MOZ_NO_REMOTE': '1', 04:53:45 INFO - 'NO_EM_RESTART': '1', 04:53:45 INFO - 'PAGER': '/bin/cat', 04:53:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:45 INFO - 'PWD': '/builds/slave/test', 04:53:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:45 INFO - 'SHELL': '/bin/bash', 04:53:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tMfQ34dDCl/Listeners', 04:53:45 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 04:53:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:45 INFO - 'USER': 'cltbld', 04:53:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:45 INFO - 'XPC_FLAGS': '0x0', 04:53:45 INFO - 'XPC_SERVICE_NAME': '0', 04:53:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:45 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)) 04:53:45 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)) 04:53:45 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)) 04:53:45 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)) 04:53:45 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)) 04:53:45 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)) 04:53:45 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)) 04:53:45 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)) 04:53:45 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)) 04:53:45 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)) 04:53:45 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)) 04:53:45 INFO - Cleaning up... 04:53:45 INFO - Return code: 0 04:53:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:45 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')]} 04:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:45 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')]} 04:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:45 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 0x10300fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030164c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c68c987c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb3d30>, '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 0x102cd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaab20>, '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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 04:53:45 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 04:53:45 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 04:53:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ON4CV5u8o/Render', 04:53:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:46 INFO - 'HOME': '/Users/cltbld', 04:53:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:46 INFO - 'LOGNAME': 'cltbld', 04:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:46 INFO - 'MOZ_NO_REMOTE': '1', 04:53:46 INFO - 'NO_EM_RESTART': '1', 04:53:46 INFO - 'PAGER': '/bin/cat', 04:53:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:46 INFO - 'PWD': '/builds/slave/test', 04:53:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:46 INFO - 'SHELL': '/bin/bash', 04:53:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tMfQ34dDCl/Listeners', 04:53:46 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 04:53:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:46 INFO - 'USER': 'cltbld', 04:53:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:46 INFO - 'XPC_FLAGS': '0x0', 04:53:46 INFO - 'XPC_SERVICE_NAME': '0', 04:53:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:46 INFO - Downloading/unpacking jsonschema 04:53:46 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 04:53:46 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 04:53:46 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 04:53:46 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 04:53:46 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 04:53:46 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 04:53:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:48 INFO - Downloading/unpacking functools32 (from jsonschema) 04:53:48 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 04:53:48 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 04:53:48 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 04:53:48 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 04:53:48 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 04:53:48 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 04:53:49 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:49 INFO - warning: no files found matching '*.txt' 04:53:49 INFO - no previously-included directories found matching 'build' 04:53:49 INFO - no previously-included directories found matching 'dist' 04:53:49 INFO - no previously-included directories found matching '.git*' 04:53:49 INFO - Installing collected packages: jsonschema, functools32 04:53:49 INFO - Running setup.py install for functools32 04:53:49 INFO - warning: no files found matching '*.txt' 04:53:49 INFO - no previously-included directories found matching 'build' 04:53:49 INFO - no previously-included directories found matching 'dist' 04:53:49 INFO - no previously-included directories found matching '.git*' 04:53:49 INFO - Successfully installed jsonschema functools32 04:53:49 INFO - Cleaning up... 04:53:49 INFO - Return code: 0 04:53:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:49 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 0x10300fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030164c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c68c987c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eb3d30>, '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 0x102cd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaab20>, '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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 04:53:49 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 04:53:49 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 04:53:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ON4CV5u8o/Render', 04:53:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:49 INFO - 'HOME': '/Users/cltbld', 04:53:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:49 INFO - 'LOGNAME': 'cltbld', 04:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:49 INFO - 'MOZ_NO_REMOTE': '1', 04:53:49 INFO - 'NO_EM_RESTART': '1', 04:53:49 INFO - 'PAGER': '/bin/cat', 04:53:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:49 INFO - 'PWD': '/builds/slave/test', 04:53:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:49 INFO - 'SHELL': '/bin/bash', 04:53:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tMfQ34dDCl/Listeners', 04:53:49 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 04:53:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:49 INFO - 'USER': 'cltbld', 04:53:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:49 INFO - 'XPC_FLAGS': '0x0', 04:53:49 INFO - 'XPC_SERVICE_NAME': '0', 04:53:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:49 INFO - Downloading/unpacking flake8 04:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:53:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:53:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 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 04:53:52 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 04:53:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:53:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:53 INFO - no previously-included directories found matching 'docs/_build' 04:53:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:53:53 INFO - Running setup.py install for pep8 04:53:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:53 INFO - no previously-included directories found matching 'docs/_build' 04:53:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:53:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:53:53 INFO - Cleaning up... 04:53:53 INFO - Return code: 0 04:53:53 INFO - Running post-action listener: _resource_record_post_action 04:53:53 INFO - Running post-action listener: _start_resource_monitoring 04:53:53 INFO - Starting resource monitoring. 04:53:53 INFO - ##### 04:53:53 INFO - ##### Running install step. 04:53:53 INFO - ##### 04:53:53 INFO - Running pre-action listener: _resource_record_pre_action 04:53:53 INFO - Running main action method: install 04:53:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:53 INFO - Reading from file tmpfile_stdout 04:53:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:54 INFO - Reading from file tmpfile_stdout 04:53:54 INFO - Output received: 04:53:54 INFO - Usage: mozinstall [options] installer 04:53:54 INFO - Options: 04:53:54 INFO - -h, --help show this help message and exit 04:53:54 INFO - -d DEST, --destination=DEST 04:53:54 INFO - Directory to install application into. [default: 04:53:54 INFO - "/builds/slave/test"] 04:53:54 INFO - --app=APP Application being installed. [default: firefox] 04:53:54 INFO - mkdir: /builds/slave/test/build/application 04:53:54 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'] 04:53:54 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 04:54:27 INFO - Reading from file tmpfile_stdout 04:54:27 INFO - Output received: 04:54:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:54:27 INFO - Running post-action listener: _resource_record_post_action 04:54:27 INFO - ##### 04:54:27 INFO - ##### Running run-tests step. 04:54:27 INFO - ##### 04:54:27 INFO - Running pre-action listener: _resource_record_pre_action 04:54:27 INFO - Running main action method: run_tests 04:54:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:54:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:54:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:54:27 INFO - 2016-03-09 04:54:27.682 screenresolution[1643:7801] starting screenresolution argv=screenresolution get 04:54:27 INFO - 2016-03-09 04:54:27.684 screenresolution[1643:7801] Display 0: 1600x1200x32@60 04:54:27 INFO - 2016-03-09 04:54:27.690 screenresolution[1644:7803] starting screenresolution argv=screenresolution list 04:54:27 INFO - Available Modes on Display 0 04:54:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:54:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:54:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:54:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:54:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:54:27 INFO - Intel Iris: 04:54:27 INFO - Chipset Model: Intel Iris 04:54:27 INFO - Type: GPU 04:54:27 INFO - Bus: Built-In 04:54:27 INFO - VRAM (Dynamic, Max): 1536 MB 04:54:27 INFO - Vendor: Intel (0x8086) 04:54:27 INFO - Device ID: 0x0a2e 04:54:27 INFO - Revision ID: 0x0009 04:54:27 INFO - Displays: 04:54:27 INFO - Display: 04:54:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:54:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:54:27 INFO - Display Serial Number: 1600x1200 60 04:54:27 INFO - Main Display: Yes 04:54:27 INFO - Mirror: Off 04:54:27 INFO - Online: Yes 04:54:27 INFO - Rotation: Supported 04:54:27 INFO - Return code: 0 04:54:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:27 INFO - Python 2.7.3 04:54:27 INFO - Return code: 0 04:54:27 INFO - grabbing minidump binary from tooltool 04:54:27 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')]} 04:54:27 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 0x102eb3d30>, '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 0x102cd7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102eaab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:27 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 04:54:27 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 04:54:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:28 INFO - Return code: 0 04:54:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:54:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:54:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:54:29 INFO - Return code: 0 04:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ON4CV5u8o/Render', 04:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:29 INFO - 'HOME': '/Users/cltbld', 04:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:29 INFO - 'LOGNAME': 'cltbld', 04:54:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:29 INFO - 'MOZ_NO_REMOTE': '1', 04:54:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:29 INFO - 'NO_EM_RESTART': '1', 04:54:29 INFO - 'PAGER': '/bin/cat', 04:54:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:29 INFO - 'PWD': '/builds/slave/test', 04:54:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:29 INFO - 'SHELL': '/bin/bash', 04:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tMfQ34dDCl/Listeners', 04:54:29 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 04:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:29 INFO - 'USER': 'cltbld', 04:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:29 INFO - 'XPC_FLAGS': '0x0', 04:54:29 INFO - 'XPC_SERVICE_NAME': '0', 04:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:54:29 INFO - mozversion application_buildid: 20160309024915 04:54:29 INFO - mozversion application_changeset: 7436297ba12f1d027e8d4ce0fb70eb4fa0acee94 04:54:29 INFO - mozversion application_display_name: Nightly 04:54:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:29 INFO - mozversion application_name: Firefox 04:54:29 INFO - mozversion application_remotingname: firefox 04:54:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:54:29 INFO - mozversion application_vendor: Mozilla 04:54:29 INFO - mozversion application_version: 48.0a1 04:54:29 INFO - mozversion platform_buildid: 20160309024915 04:54:29 INFO - mozversion platform_changeset: 7436297ba12f1d027e8d4ce0fb70eb4fa0acee94 04:54:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:54:29 INFO - mozversion platform_version: 48.0a1 04:54:29 INFO - using testdate: 1457528069 04:54:29 INFO - actual date: 1457528069 04:54:29 INFO - starting webserver on 'localhost:49273' 04:54:29 INFO - SUITE-START | Running 2 tests 04:54:29 INFO - TEST-START | dromaeo_css 04:54:29 INFO - operating with platform_type : mac_ 04:54:29 INFO - Initialising browser for dromaeo_css test... 04:54:29 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmp4aWU9k/profile http://localhost:49273/getInfo.html) 04:54:32 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 04:54:32 INFO - PROCESS | 1662 | colorDepth:24 04:54:32 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 04:54:32 INFO - PROCESS | 1662 | __metrics 04:54:32 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 04:54:33 INFO - TEST-INFO | 1662: exit 0 04:54:33 INFO - Browser initialized. 04:54:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:33 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmp4aWU9k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:45 INFO - PROCESS | 1666 | RSS: Main: 256299008 04:54:45 INFO - PROCESS | 1666 | 04:55:34 INFO - PROCESS | 1666 | 1457528134898 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] 04:57:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 04:57:47 INFO - PROCESS | 1666 | RSS: Main: 267931648 04:57:47 INFO - PROCESS | 1666 | 05:00:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 05:00:49 INFO - PROCESS | 1666 | RSS: Main: 279670784 05:00:49 INFO - PROCESS | 1666 | 05:03:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 05:03:52 INFO - PROCESS | 1666 | RSS: Main: 282193920 05:03:52 INFO - PROCESS | 1666 | 05:06:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 05:06:54 INFO - PROCESS | 1666 | RSS: Main: 284102656 05:06:54 INFO - PROCESS | 1666 | 05:09:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 05:09:57 INFO - PROCESS | 1666 | RSS: Main: 285888512 05:09:57 INFO - PROCESS | 1666 | 05:13:00 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 05:13:00 INFO - PROCESS | 1666 | RSS: Main: 288792576 05:13:00 INFO - PROCESS | 1666 | 05:13:00 INFO - PROCESS | 1666 | __start_tp_report 05:13:00 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:13:00 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:13:00 INFO - PROCESS | 1666 | |i|pagename|runs| 05:13:00 INFO - PROCESS | 1666 | |0;dojo.html;2868.2542538939883;3513.6662017108374;3517.3668739626855;3550.6271841456646;3592.0840185752645;5737.2541569596;5738.483536481715;5768.1059435787465;5776.39347868474;5788.739506722197;5693.202951586771;5703.914441283374;5768.480836724694;5855.677937713434;5983.850403739909;5224.111900976834;5254.81608143715;5282.7358632068435;5295.655782374133;5305.628605997563;5329;5347.46525347466;5365.946340536584;5394;5394.271773310612;5208.531232189102;5249.658772179834;5337.946620533784;5338.439463856317;5355.571554275649;5255.842324730264;5267.86830329241;5298.337707786527;5331.626786124973;5368.00691872005;5157.5616072633875;5240.0567897778765;5268.078086334915;5279.9208011879855;5328.8401347959625;5673.23411339468;5719.3422756382715;5766;5780.797672081457;5816.272965879265;5188;6182.319944806068;6211.9068213976825;6239.313675495737;6258.71835767387;6133.763142530635;6176.104464852571;6200.534959878028;6220.720067596969;6247.187865577492;5190.766415511311;5693.743781529841;5768.480836724715;5988.401159884064;5992.490638295793;6358.682065896686;6378.425941665272;6386.584871983307;6400.647964362005;6411.67941602918;6107;6179.196704428396;6210.192674952227;6224.875502489925;6288.371162883675;6102.542309326729;6164.4760195383;6218.782342617987;6228.065790131516;6228.781992630236;6174.135621013062;6201.596896201732;6218.440340369389;6233.189685340877;6247.406496382836;6120.0205129226715;6150.630962142286;6177.4749146322165;6194.34959329273;6254.21822272216;4946.1344264753525;4993.80024799004;4999.75001249936;5020.799168033311;5026.321446604735;4479.59683628475;4489.057297967398;4494.438195225597;4518.71216703238;4544.136614043321;5065.848024559269;5871.794487192928;5915.3788852170765;5945.910811337833;6040.244969378828;6242.1261023456755;6273.247210334789;6279.560430769893;6279.623222606567;6302.684865756693;5817.7382017809305;6009.969950150221;6019.939800602026;6021.397860214031;6043.153958445821;4763.190257656207;5442.102053161263;5448.318960129984;5468.808591699351;5503.064479038573;5721.342045664718;6110.602810817282;6443.1946006750095;6451.741930322828;6488.351164883474;6123.953766440777;6164.106204600397;6290.622562646256;6291.874162516816;6307.463865571478;6399.456046236122;6449.838754031187;6506.967465162644;6517.055027020961;6536.281009088902;4899.706017638953;5118.9506151238165;5927.081302398135;6158.199434073542;6193.783217587363;5288.524032837063;5660.264165658438;5777.45114214149;6241.251049874044;6297.338779428094;6091.664958427329;6139.706800529493;6191.81424557264;6199.783007594712;6230.283517395376;6118.174046503665;6171.9074213887725;6174.413430724074;6213.596116252429;6214.130021796862;5804.477597016289;6031.185789918481;6066.817995460143;6082.72627731762;6094;5649.745761440663;5729.882672878749;6116.579253789288;6138.785142519991;6190.50475961913;6090.208272924491;6126.693665316806;6132.356102609162;6146.754129834757;6146.969265153824 05:13:00 INFO - PROCESS | 1666 | |1;ext.html;461.9699719518233;569.4305694305693;595.7438301530345;605.142218357968;642.5887432043492;32367.028989130333;38760.61239387605;38784;38902.44390224391;39100.80449597748;42448.57551424485;42512.57487425125;42690;42823;42886.92782680435;9527.19018883394;9748.463834489101;9761.170300524464;9770.609175632966;9771.706848794547;9659.5170241488;9768.462734549597;9791.804163916753;9823;9827.950860245688;9735.75660608487;9782.26633002524;9831.901680983206;9844.803103937917;9855.211583073373;9639.855402168972;9696.0788725071;9773.902260977371;9786.608535658565;9798.216142708601;9586.185174260196;9635.759106022335;9694.75763105928;9695;9723.90276097237;33089.6691033089;40034.19931601381;40212.994675133064;40253.39619905704;40537.391939120935;3113.143885431502;3254.08885512057;3291.243014106769;3377.4258376076127;3490.2670439207795;23275.883620581957;28883.555822209015;29427.411451770844;30007.399852002836;30129.397412051636;2805.1724741201397;2815.563587643898;2850.330172409482;2916.2271997920566;2973.940521189564;513226;516931;525335;525698.9999999962;526899;46092.53907460949;48009.5199048012;75836.62081689667;76589;76753;48246.79383015453;48338;48404.789880252574;48648.78378040577;48738.512614874104;15706.921465392828;15848.44530441429;15880.364785408454;15915.840841591667;16004.439844605384;12509.687257818627;12516.624501264976;12536.623901282976;12702.047346449053;12733.426995785212;15303.540893773205;15388.769168462482;15443.922780386027;15619.453319133776;16045.839541604668;5918.615290006136;7030.332118448841;7038.436925045984;7093.538919970186;7437.628118594049;815.5514467043103;861.8922634670666;876.7390482256229;1001.234055947201;1024.6413755185774;29686.406271874443;29819.80720771145;29948;30236.84881575622;30353.848230759148;1041.3543602966058;1119.5857532712948;1154.543955137716;1161.7676464707092;1174.8766379530027;15304.99186488723;15361.385544578316;15375.384984600714;15438.996465229724;15615.453459129103;533205;537747;542715;543258;544147;52288.73855630698;55052;61457;61596.38403615996;61836;1439.359485029152;1445.4001589340517;1454.919979401143;1460.715160543705;1590.7852439920694;28551.857240713663;29667.258318542208;29830.403391931606;30029.24926876758;30046.09861704065;52966.205506918195;54220.186697198784;54526;54817;54923.450765493435;481455;495915;497900;498488;499494;34901.47647785336;35255.82372088123;35348.46977295394;35850.46224306586;44749.776251118536;44274.77862610795;44401.11197775962;44919;44996.55003450054;45187.54812451833;37085.88742337734;37274.813625931696;37516.43725344176;37566.812165938994;38490.498117622265;37492.62507374891;37732.46695048218;37753.867383978526;38306.23387532178;38581.2283754329;32052.83973580117;37238;37263.06842328963;38138.618613814615;38488.80755596204;27936.161915142577;33679.98960031203;33730.66269337275;33953.83023084869;34766.47850282197;24282.514349712554;24322.391940201636;24742;24802.50394992126;24834.503309933338 05:13:00 INFO - PROCESS | 1666 | |2;jquery.html;359.99999999999983;365.2986266368572;370.9276691045246;375.6487684015446;376.78334957399466;15660.21698915054;17270.827291727095;18066.458006259818;19921;19936.003199840023;20705.482362940897;21327.933603319812;21388.57222855542;21551.245706400277;21557.1377144914;5567.66594004359;5763.164341170528;5848.385919478457;5865.237519122508;5878.177055212273;5592.238444889867;5696.914546281809;5712.2574065371655;5796.913046304308;5799.681017544033;5037.29477873098;5562.137868630369;5595.076812325961;5731.570132240078;5750.856228594277;5518.668879867221;5581.330240371161;5598.048331783607;5674.347450043257;5706.914396284038;4904.705717656916;4919.11455937931;4929.014197160583;4929.137400954819;4940.110780059588;19188.520286992796;20163.99180040992;25429.98280068795;25459.745402545923;25695.61456578153;2110.947226319339;2221.955560888773;2243.461569223391;2253.6056190166655;2270.14869423966;14472.782908256384;14648.340824662915;15135.243237838175;15164.090154590649;15416.3833446662;1778.0754007915941;1799.8650101242329;1823.188681036939;1845.335679155503;1863.515485973643;88599.67100493498;103486;106715;108867;109283.81432371387;10201.744956376002;10734.624288149877;10742.194335424874;10862.565497380016;10896.891031089588;12718.618441446772;12827.743445131046;12905.35473226335;12905.935470322589;12906.354682266037;8431.409801313972;8459.70391036323;8471.025832029272;8494.277986371104;8569.928758905136;8665.696700615448;8690.174433428814;8698.60856261457;8786.384953053224;8797.956010219908;6277.05844123376;6303.338149494237;6311.621302721851;6343.5876668016435;6349.301576826545;1867.4957761404344;1899.4206766936218;1904.961900761977;1904.9904750476437;1911.9866470770514;929.4562680831789;953.0183910572122;969.8496733006396;1008.621766837436;1081.9242653014371;19814.306499272458;20397.592048158953;20753.782286908925;21537.784622153893;21577.892110539346;969.1374676537887;991.0832479956156;1032.5972870580479;1063.7340664833791;1072.8873468285874;11008.779824403468;11385.715357116138;11444;11446.828297575543;11465.71335716597;630340;630636;636374;658288;692801;85974;92272.53863730638;94810;99597;104404;1022.1158697726413;1026.14829691356;1045.7019749371545;1054.615065501102;1058.349115294104;18624.348147814762;19075.332363367215;19177.32879349216;19196.808031919503;19506.609867802847;49054.75472622614;50600.240996384346;50889.745551272004;51926.480735193676;53216.46783532115;63222;63814.08557743275;65463;66583.67952967298;69841;7728.304452599293;7738.806529836799;7832.373410127062;7928.920710792819;7950.324222441157;12963.287019214034;13028.5440009603;13086.345682716017;13350.465981360638;13513;11198.272112312674;11344.262622929813;11462.541498339973;11487.770244595229;11494.137939654393;11117.722056948318;11125.666230012788;11164.944175279072;11455.942720286344;11458.140639452242;11473.82789258145;11483.712907177052;11562.248453850472;11732.589359372723;11990.280583165038;7639.159692433716;7813.02337207849;7832.412569057229;7847.136814950465;8028.554860125234;8747.781305467413;9549.28380371461;11057.61298354586;11261.268017578832;11382.317060976036 05:13:00 INFO - PROCESS | 1666 | |3;mootools.html;1604.7031299209648;1617.5794293483693;1675.6983742926268;2007.498125468632;2014.0835919656558;7921.326687231578;8689.435186712875;8872.955635221822;9096.999330073686;9189.632414703412;8795.692150774725;8808.207261346477;8841.292696584274;8846;8853.5573221339;2440.2313271319567;2467.2968204061845;2467.3338198686342;2471.5180539794746;2475.4801491686767;1896.5163883209832;2094.2042024030848;2382.28531440568;2490.7633774791366;2495.263897150336;2463.08865719684;2475.158446128316;2491.1530079772874;2500.299916023507;2504.5742223821903;2457.5330687169558;2458.053649344997;2459.385153711572;2462.0151939224365;2486.167134010109;2215.4129155773735;2393.6236663918144;2446.1805295226122;2459.5449841779327;2481.8634975076366;8851.070637583025;8891.73324800257;8916.643334266622;8941.329400295004;8970.910290897073;5394.757235924393;5521.944780552183;5533.6956467394275;5540.612157149001;5572.247746554204;3571.4464258040043;3671.504346913186;3673.9265214695824;3683.355412802749;3708.035910663247;1044.9791004179874;1067.7757670889123;1069.0645685025602;1076.4994277660846;1078.9730256743567;12000.579979700757;12016;12182.329971851634;12187.45156467961;12292.877071229352;4892.437369702458;4911.017796440726;4966.6771659842;5005.249212618136;5027.572656324253;10148.898511014795;10247.026532479402;10247.333923295111;10264.127549158406;10274.33216840903;5505.256790333254;5523.392426833045;5525.4474552545225;5536.557075433956;5536.667799932017;4460.732356058582;4975.900481990412;4993.7503124843615;4993.825216117419;5027.497250275016;3916.8824935251987;3944.6647035002347;3973.960260397359;4002.399640054015;4044.716869819143;1345.9730805384033;1350.2506109109538;1365.7336819320335;1366.269046060353;1379.717157982611;1365.9726805463836;1373.7252549490142;1397.6925076483158;1402.1236727045596;1414.3918115210352;8139.30815880645;8180.100188979208;8198.672053117927;8341.749747507585;8379.162083791573;523.7486006716797;533.3040382301057;534.6284332388952;538.3485981961792;539.1131588536913;6194.4115309045565;6207;6219.751209951552;6267.592606480655;6290.433860952537;10592.894071059345;10726.678199654023;10897.128229741602;10988.340699558052;11165.497552610152;10525.9473702631;10565.788684226272;10592.205584581186;10752.462376881125;10800.78398432027;8459;8479.95760021196;8515.872261916076;8590.269827064645;8634.784130396665;7808.063032436144;7815.882761758465;7861.371090312647;7982.401319900914;8069.193080691884;9471.952640236756;9611.519424028911;9611.807763844823;9656.903430965882;9718.611255549698;9632.084951929555;9718.757031073997;9998.500074996076;10061.949690251502;10152.746181345525;5530.169306118486;7183.568985860865;7344.155422126524;7539.547627142389;7615.5430674159725;8004.439689221931;8095.352371810123;8185.959070204611;8200.138985406686;8256.215659512336;6438.581492202992;7341.889871652036;7374.852502950018;7458.73894413693;7540.132884718328;5635.619273278073;7102.112235970504;7198.280171982759;7274.563526188445;7411.444141689287;7466.36535894455;7590;7623.313901748647;7707.075150981918;7773;7069.858602827811;7076.681549330189;7079.82300442493;7104.431645468247;7140.321669441395;5784.363719990882;6136.846578835565;7002.719891204295;7080.610566418896;7227.638618069181 05:13:00 INFO - PROCESS | 1666 | |4;prototype.html;280.62396388838954;328.8355822088956;329.53041915270734;332.2043705325745;338.2355875720872;6844.726210951562;6926.792196234115;6944.375006249436;6945.270746571613;6966.5820050796865;6805.523613347068;6905.343992320734;6949.756758513453;6969.651517424121;6989.370956613904;4896.387951506062;4975.12935236334;5121.462246464123;5125.3342663634285;5154.536091751742;3893;4463.575960283768;5080.695158290496;5106.131957567222;5121.590272778169;4061.6547593454593;5006.699598024112;5027.84916452507;5027.899442011176;5045.747712614373;5043.873903152432;5085.542301192911;5093.0577843099145;5093.414257360396;5099.617528685345;3614.331348700499;4353.673474489426;4356.607905288539;4362.36745671879;4365.7817109144735;5440.347158341025;6360.55476116672;6678.9332106679285;6711.798646040626;6728.058071869942;5823.068309070529;5863.149843272701;5898.817437548135;5908.350081491032;5916.763329466816;7353.30143636359;7353.558786472775;7357.264273572653;7358.190599034102;7381.224971378036;4650.395448591696;4674.228752255874;4675.275332323461;4684.8360307389075;4693.084848454553;7746.612669366566;7798.167430653849;7810.140884502757;7827.3346765525;7827.765167044998;4503.662225333113;4544.7727613619845;4631.6294696424875;4698.459677137104;4705.12955103307;4773.809047638125;4776.761161941889;4785.186518291899;4785.617150627942;4806.735629540339;4654.790534425959;4654.999175177353;4723.834665786681;5337.092694241988;5821.88356232873;6309.621422714652;7316.6341682915645;7323.450741194431;7338.963305183546;7363.226861179606;1647.398699474707;1664.758610001543;1669.2154687296952;1669.933202671904;1682.1841406917636;973.8557195295499;989.6387818446216;998.2812375089924;1063.3088492479949;1082.7996820588216;6814.522983391115;6895.655217239118;6910.516263861582;6918.273581273995;6927.411170050602;6884.931150688529;7585.734499292498;7638.350740187147;7641.35048520882;7647.923520764833;6833.350831670983;6862.416694580917;6878.965605171942;6893.551919125241;6913.274106218875;3912.8434862605745;3923.7253392262837;4011.618896204856;4030.536488303824;4038.919221615551;7856.450048496665;7999.880001799977;8028.996375453068;8046.959765201136;8092.069412017576;7943.960280198562;7995.2804247618;8003.799905002422;8011.679532818622;8012;6487.54587178893;8060.637271322687;8063.758087257392;8072.031356237172;8102.4733392328135;7456.55260684339;7716.459847810599;7717.2668596483245;7731.149573546792;7753.37972962173;7482.588457634883;7518.586477743558;7631.771046868603;7638.694452221849;7650.579218142833;8121.75634730959;8123.0658474276215;8142.267195952392;8145.307648849915;8160.673573057011;4738.455077666113;4775.5463230993;4779.665423420327;4780.521947805191;4788.4253889533475;7540.245975402416;7716.459847810599;7748.57382843949;7750.534967901944;7759.301662850145;7344.339009489172;7396.149442814145;7414.518056326321;7434.925650743423;7436.405087593088;7393.852122957618;7399.482036257626;7403.185649578434;7413.592252426169;7451.441141914486;6929;7189.460790440633;7203.783886483414;7221.205667376479;7264.818379540554;7363.153237377556;7403.222661620668;7407.370373518312;7429.257074292527;7434.516756410816;5844.795432159854;5864.794732184353;6123.785667501795;6407.711652975534;7253.891191632235 05:13:00 INFO - PROCESS | 1666 | |5;yui.html;717.748598847222;725.8584576007679;726.7129483853878;764.8393837294168;782.0966783365211;14873.107613543196;15156.1664108474;15380.846191538081;15383.077015379085;15431.07413555186;14380.49668261611;14495.275236238198;14497.057691250062;14573.271336433163;14780.556583302518;773.2731232641328;934.5140526926011;949.7957939043105;964.5129209749067;965.8985806490323;928.1924725488834;953.7615596100975;956.8803899512561;958.1185309515263;959.0984474593894;1007.4308015970989;1012.696191142658;1014.985014985015;1015.3501758874327;1016.1464369929258;979.8628192053083;986.5461887531673;1004.8442491413842;1008.5108722269694;1009.0262896305064;716.8745469542861;727.8253219227347;730.9853802923965;749.7375918428561;751.3763576231714;14890.329935152835;14898.627534311621;15100.697986040328;15285.929984901062;15288.159151246677;12954.870451295461;12967.740645187137;13009.674758131028;13111;13169.670758231025;8379.49723016621;9961.628469779318;9965.850512242323;9981.726815897648;10055.195584353234;3462.23830757233;3486.703630191437;3497.143199916037;3546.148924258185;3607.062163837395;78271;78666.6066669663;80113.59943200246;81928;82213.58893205496;8008.719694810654;9427.575759090858;9548.1884039856;9549.952250238704;9628;21984.90075496219;22063.66904496434;22074.66887996681;22101.33695989123;22142.114315427523;7561.168271490132;7647.961760191275;7702.73040443593;7715.652795624211;7785.1436342002335;4041.4948131483566;4074.368472886648;4163.2298024864895;4164.4586203793315;4165.354370072643;3523.2248905241318;3525.9471107932886;3532.2229109595846;3552.982235088808;3577.767445116059;638.7125793392992;656.0716586030713;656.8259411256021;658.6607896933083;660.0594153331483;548.7530611224964;586.2818047891384;602.2682440834408;608.0392979093023;611.119987218404;8070.192980701883;8213.425060245845;8326.375521835887;8359.331253499706;8437.704680336281;539.0405078959459;592.1059200607115;615.7506209984963;616;632.9746810127635;3800.2969450651717;3855.9614403856162;3942.5071866016747;3983.6215559521797;3988.760674359548;73557.6322118386;73599.63200184071;73865;73899.63050184715;78747;37449.43825842615;56738.14892776612;58061.8387632245;58672;59441.10838337428;49658.255126173855;64482;65127.67436162789;65780;65911.34088659148;8046.879296810435;8285.295749861329;8421.70524031656;8448.028476725256;8509.702160424355;44873.77563112294;47773;51775.74112129415;52316.73841630767;56469;56250;63926.04110938433;71080.28919710944;71746;74161.25838741759;10371.844422333821;10405.375677459377;11355.659330220107;11574.18980671345;11607.825882611598;8838.734837954871;11232.438378081226;12081.577144800242;12102;12522;9121.589528471102;10793.67618971432;11289.491972861406;11342.546298147981;11866.584669536525;11604.535818567163;11608.825867612162;11852.52589896429;12004.519819207135;12072.75854482888;11308.886911131112;11404.087672985976;11711.180217385043;11725.530978760755;11729.765404691687;9346.439213647203;9632.662856799978;9640.373375730554;9715;9844.40933543961;9694;9781.364211326241;9788.168005719594;9809.460479673686;9870.358426702529 05:13:00 INFO - PROCESS | 1666 | __end_tp_report 05:13:00 INFO - PROCESS | 1666 | __start_cc_report 05:13:00 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,363 05:13:00 INFO - PROCESS | 1666 | __end_cc_report 05:13:00 INFO - PROCESS | 1666 | __startTimestamp1457529180261__endTimestamp 05:13:00 INFO - PROCESS | 1666 | 05:13:00 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:13:00 INFO - PROCESS | 1666 | Number of tests: 6 05:13:00 INFO - PROCESS | 1666 | 05:13:00 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5761.03 Median:6019.94 stddev:640.11 (10.6%) stddev-sans-first:600.50 05:13:00 INFO - PROCESS | 1666 | Values: 2868.3 3513.7 3517.4 3550.6 3592.1 5737.3 5738.5 5768.1 5776.4 5788.7 5693.2 5703.9 5768.5 5855.7 5983.9 5224.1 5254.8 5282.7 5295.7 5305.6 5329.0 5347.5 5365.9 5394.0 5394.3 5208.5 5249.7 5337.9 5338.4 5355.6 5255.8 5267.9 5298.3 5331.6 5368.0 5157.6 5240.1 5268.1 5279.9 5328.8 5673.2 5719.3 5766.0 5780.8 5816.3 5188.0 6182.3 6211.9 6239.3 6258.7 6133.8 6176.1 6200.5 6220.7 6247.2 5190.8 5693.7 5768.5 5988.4 5992.5 6358.7 6378.4 6386.6 6400.6 6411.7 6107.0 6179.2 6210.2 6224.9 6288.4 6102.5 6164.5 6218.8 6228.1 6228.8 6174.1 6201.6 6218.4 6233.2 6247.4 6120.0 6150.6 6177.5 6194.3 6254.2 4946.1 4993.8 4999.8 5020.8 5026.3 4479.6 4489.1 4494.4 4518.7 4544.1 5065.8 5871.8 5915.4 5945.9 6040.2 6242.1 6273.2 6279.6 6279.6 6302.7 5817.7 6010.0 6019.9 6021.4 6043.2 4763.2 5442.1 5448.3 5468.8 5503.1 5721.3 6110.6 6443.2 6451.7 6488.4 6124.0 6164.1 6290.6 6291.9 6307.5 6399.5 6449.8 6507.0 6517.1 6536.3 4899.7 5119.0 5927.1 6158.2 6193.8 5288.5 5660.3 5777.5 6241.3 6297.3 6091.7 6139.7 6191.8 6199.8 6230.3 6118.2 6171.9 6174.4 6213.6 6214.1 5804.5 6031.2 6066.8 6082.7 6094.0 5649.7 5729.9 6116.6 6138.8 6190.5 6090.2 6126.7 6132.4 6146.8 6147.0 05:13:00 INFO - PROCESS | 1666 | 05:13:00 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:65731.42 Median:39001.62 stddev:138259.15 (354.5%) stddev-sans-first:138560.15 05:13:00 INFO - PROCESS | 1666 | Values: 462.0 569.4 595.7 605.1 642.6 32367.0 38760.6 38784.0 38902.4 39100.8 42448.6 42512.6 42690.0 42823.0 42886.9 9527.2 9748.5 9761.2 9770.6 9771.7 9659.5 9768.5 9791.8 9823.0 9828.0 9735.8 9782.3 9831.9 9844.8 9855.2 9639.9 9696.1 9773.9 9786.6 9798.2 9586.2 9635.8 9694.8 9695.0 9723.9 33089.7 40034.2 40213.0 40253.4 40537.4 3113.1 3254.1 3291.2 3377.4 3490.3 23275.9 28883.6 29427.4 30007.4 30129.4 2805.2 2815.6 2850.3 2916.2 2973.9 513226.0 516931.0 525335.0 525699.0 526899.0 46092.5 48009.5 75836.6 76589.0 76753.0 48246.8 48338.0 48404.8 48648.8 48738.5 15706.9 15848.4 15880.4 15915.8 16004.4 12509.7 12516.6 12536.6 12702.0 12733.4 15303.5 15388.8 15443.9 15619.5 16045.8 5918.6 7030.3 7038.4 7093.5 7437.6 815.6 861.9 876.7 1001.2 1024.6 29686.4 29819.8 29948.0 30236.8 30353.8 1041.4 1119.6 1154.5 1161.8 1174.9 15305.0 15361.4 15375.4 15439.0 15615.5 533205.0 537747.0 542715.0 543258.0 544147.0 52288.7 55052.0 61457.0 61596.4 61836.0 1439.4 1445.4 1454.9 1460.7 1590.8 28551.9 29667.3 29830.4 30029.2 30046.1 52966.2 54220.2 54526.0 54817.0 54923.5 481455.0 495915.0 497900.0 498488.0 499494.0 34901.5 35255.8 35348.5 35850.5 44749.8 44274.8 44401.1 44919.0 44996.6 45187.5 37085.9 37274.8 37516.4 37566.8 38490.5 37492.6 37732.5 37753.9 38306.2 38581.2 32052.8 37238.0 37263.1 38138.6 38488.8 27936.2 33680.0 33730.7 33953.8 34766.5 24282.5 24322.4 24742.0 24802.5 24834.5 05:13:00 INFO - PROCESS | 1666 | 05:13:00 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34775.23 Median:11899.92 stddev:107001.92 (899.2%) stddev-sans-first:107270.88 05:13:00 INFO - PROCESS | 1666 | Values: 360.0 365.3 370.9 375.6 376.8 15660.2 17270.8 18066.5 19921.0 19936.0 20705.5 21327.9 21388.6 21551.2 21557.1 5567.7 5763.2 5848.4 5865.2 5878.2 5592.2 5696.9 5712.3 5796.9 5799.7 5037.3 5562.1 5595.1 5731.6 5750.9 5518.7 5581.3 5598.0 5674.3 5706.9 4904.7 4919.1 4929.0 4929.1 4940.1 19188.5 20164.0 25430.0 25459.7 25695.6 2110.9 2222.0 2243.5 2253.6 2270.1 14472.8 14648.3 15135.2 15164.1 15416.4 1778.1 1799.9 1823.2 1845.3 1863.5 88599.7 103486.0 106715.0 108867.0 109283.8 10201.7 10734.6 10742.2 10862.6 10896.9 12718.6 12827.7 12905.4 12905.9 12906.4 8431.4 8459.7 8471.0 8494.3 8569.9 8665.7 8690.2 8698.6 8786.4 8798.0 6277.1 6303.3 6311.6 6343.6 6349.3 1867.5 1899.4 1905.0 1905.0 1912.0 929.5 953.0 969.8 1008.6 1081.9 19814.3 20397.6 20753.8 21537.8 21577.9 969.1 991.1 1032.6 1063.7 1072.9 11008.8 11385.7 11444.0 11446.8 11465.7 630340.0 630636.0 636374.0 658288.0 692801.0 85974.0 92272.5 94810.0 99597.0 104404.0 1022.1 1026.1 1045.7 1054.6 1058.3 18624.3 19075.3 19177.3 19196.8 19506.6 49054.8 50600.2 50889.7 51926.5 53216.5 63222.0 63814.1 65463.0 66583.7 69841.0 7728.3 7738.8 7832.4 7928.9 7950.3 12963.3 13028.5 13086.3 13350.5 13513.0 11198.3 11344.3 11462.5 11487.8 11494.1 11117.7 11125.7 11164.9 11455.9 11458.1 11473.8 11483.7 11562.2 11732.6 11990.3 7639.2 7813.0 7832.4 7847.1 8028.6 8747.8 9549.3 11057.6 11261.3 11382.3 05:13:00 INFO - PROCESS | 1666 | 05:13:00 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:6064.33 Median:538.73 stddev:3232.63 (600.0%) stddev-sans-first:3224.32 05:13:00 INFO - PROCESS | 1666 | Values: 1604.7 1617.6 1675.7 2007.5 2014.1 7921.3 8689.4 8873.0 9097.0 9189.6 8795.7 8808.2 8841.3 8846.0 8853.6 2440.2 2467.3 2467.3 2471.5 2475.5 1896.5 2094.2 2382.3 2490.8 2495.3 2463.1 2475.2 2491.2 2500.3 2504.6 2457.5 2458.1 2459.4 2462.0 2486.2 2215.4 2393.6 2446.2 2459.5 2481.9 8851.1 8891.7 8916.6 8941.3 8970.9 5394.8 5521.9 5533.7 5540.6 5572.2 3571.4 3671.5 3673.9 3683.4 3708.0 1045.0 1067.8 1069.1 1076.5 1079.0 12000.6 12016.0 12182.3 12187.5 12292.9 4892.4 4911.0 4966.7 5005.2 5027.6 10148.9 10247.0 10247.3 10264.1 10274.3 5505.3 5523.4 5525.4 5536.6 5536.7 4460.7 4975.9 4993.8 4993.8 5027.5 3916.9 3944.7 3974.0 4002.4 4044.7 1346.0 1350.3 1365.7 1366.3 1379.7 1366.0 1373.7 1397.7 1402.1 1414.4 8139.3 8180.1 8198.7 8341.7 8379.2 523.7 533.3 534.6 538.3 539.1 6194.4 6207.0 6219.8 6267.6 6290.4 10592.9 10726.7 10897.1 10988.3 11165.5 10525.9 10565.8 10592.2 10752.5 10800.8 8459.0 8480.0 8515.9 8590.3 8634.8 7808.1 7815.9 7861.4 7982.4 8069.2 9472.0 9611.5 9611.8 9656.9 9718.6 9632.1 9718.8 9998.5 10061.9 10152.7 5530.2 7183.6 7344.2 7539.5 7615.5 8004.4 8095.4 8186.0 8200.1 8256.2 6438.6 7341.9 7374.9 7458.7 7540.1 5635.6 7102.1 7198.3 7274.6 7411.4 7466.4 7590.0 7623.3 7707.1 7773.0 7069.9 7076.7 7079.8 7104.4 7140.3 5784.4 6136.8 7002.7 7080.6 7227.6 05:13:00 INFO - PROCESS | 1666 | 05:13:00 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5972.16 Median:6894.60 stddev:1981.25 (28.7%) stddev-sans-first:1940.21 05:13:00 INFO - PROCESS | 1666 | Values: 280.6 328.8 329.5 332.2 338.2 6844.7 6926.8 6944.4 6945.3 6966.6 6805.5 6905.3 6949.8 6969.7 6989.4 4896.4 4975.1 5121.5 5125.3 5154.5 3893.0 4463.6 5080.7 5106.1 5121.6 4061.7 5006.7 5027.8 5027.9 5045.7 5043.9 5085.5 5093.1 5093.4 5099.6 3614.3 4353.7 4356.6 4362.4 4365.8 5440.3 6360.6 6678.9 6711.8 6728.1 5823.1 5863.1 5898.8 5908.4 5916.8 7353.3 7353.6 7357.3 7358.2 7381.2 4650.4 4674.2 4675.3 4684.8 4693.1 7746.6 7798.2 7810.1 7827.3 7827.8 4503.7 4544.8 4631.6 4698.5 4705.1 4773.8 4776.8 4785.2 4785.6 4806.7 4654.8 4655.0 4723.8 5337.1 5821.9 6309.6 7316.6 7323.5 7339.0 7363.2 1647.4 1664.8 1669.2 1669.9 1682.2 973.9 989.6 998.3 1063.3 1082.8 6814.5 6895.7 6910.5 6918.3 6927.4 6884.9 7585.7 7638.4 7641.4 7647.9 6833.4 6862.4 6879.0 6893.6 6913.3 3912.8 3923.7 4011.6 4030.5 4038.9 7856.5 7999.9 8029.0 8047.0 8092.1 7944.0 7995.3 8003.8 8011.7 8012.0 6487.5 8060.6 8063.8 8072.0 8102.5 7456.6 7716.5 7717.3 7731.1 7753.4 7482.6 7518.6 7631.8 7638.7 7650.6 8121.8 8123.1 8142.3 8145.3 8160.7 4738.5 4775.5 4779.7 4780.5 4788.4 7540.2 7716.5 7748.6 7750.5 7759.3 7344.3 7396.1 7414.5 7434.9 7436.4 7393.9 7399.5 7403.2 7413.6 7451.4 6929.0 7189.5 7203.8 7221.2 7264.8 7363.2 7403.2 7407.4 7429.3 7434.5 5844.8 5864.8 6123.8 6407.7 7253.9 05:13:00 INFO - PROCESS | 1666 | 05:13:00 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:16970.81 Median:29632.05 stddev:22632.61 (76.4%) stddev-sans-first:22663.19 05:13:00 INFO - PROCESS | 1666 | Values: 717.7 725.9 726.7 764.8 782.1 14873.1 15156.2 15380.8 15383.1 15431.1 14380.5 14495.3 14497.1 14573.3 14780.6 773.3 934.5 949.8 964.5 965.9 928.2 953.8 956.9 958.1 959.1 1007.4 1012.7 1015.0 1015.4 1016.1 979.9 986.5 1004.8 1008.5 1009.0 716.9 727.8 731.0 749.7 751.4 14890.3 14898.6 15100.7 15285.9 15288.2 12954.9 12967.7 13009.7 13111.0 13169.7 8379.5 9961.6 9965.9 9981.7 10055.2 3462.2 3486.7 3497.1 3546.1 3607.1 78271.0 78666.6 80113.6 81928.0 82213.6 8008.7 9427.6 9548.2 9550.0 9628.0 21984.9 22063.7 22074.7 22101.3 22142.1 7561.2 7648.0 7702.7 7715.7 7785.1 4041.5 4074.4 4163.2 4164.5 4165.4 3523.2 3525.9 3532.2 3553.0 3577.8 638.7 656.1 656.8 658.7 660.1 548.8 586.3 602.3 608.0 611.1 8070.2 8213.4 8326.4 8359.3 8437.7 539.0 592.1 615.8 616.0 633.0 3800.3 3856.0 3942.5 3983.6 3988.8 73557.6 73599.6 73865.0 73899.6 78747.0 37449.4 56738.1 58061.8 58672.0 59441.1 49658.3 64482.0 65127.7 65780.0 65911.3 8046.9 8285.3 8421.7 8448.0 8509.7 44873.8 47773.0 51775.7 52316.7 56469.0 56250.0 63926.0 71080.3 71746.0 74161.3 10371.8 10405.4 11355.7 11574.2 11607.8 8838.7 11232.4 12081.6 12102.0 12522.0 9121.6 10793.7 11289.5 11342.5 11866.6 11604.5 11608.8 11852.5 12004.5 12072.8 11308.9 11404.1 11711.2 11725.5 11729.8 9346.4 9632.7 9640.4 9715.0 9844.4 9694.0 9781.4 9788.2 9809.5 9870.4 05:13:00 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:13:00 INFO - PROCESS | 1666 | 05:13:00 INFO - TEST-INFO | 1666: exit 0 05:13:00 INFO - TEST-OK | dromaeo_css | took 1111361ms 05:13:00 INFO - TEST-START | kraken 05:13:00 INFO - operating with platform_type : mac_ 05:13:00 INFO - Initialising browser for kraken test... 05:13:00 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmp0u6YKR/profile http://localhost:49273/getInfo.html) 05:13:03 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 05:13:03 INFO - PROCESS | 1677 | colorDepth:24 05:13:03 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 05:13:03 INFO - PROCESS | 1677 | __metrics 05:13:03 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 05:13:04 INFO - TEST-INFO | 1677: exit 0 05:13:04 INFO - Browser initialized. 05:13:04 INFO - Running cycle 1/1 for kraken test... 05:13:04 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmp0u6YKR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:13:16 INFO - PROCESS | 1680 | RSS: Main: 255287296 05:13:16 INFO - PROCESS | 1680 | 05:13:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 05:13:19 INFO - PROCESS | 1680 | RSS: Main: 266919936 05:13:19 INFO - PROCESS | 1680 | 05:13:22 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 05:13:22 INFO - PROCESS | 1680 | RSS: Main: 276647936 05:13:22 INFO - PROCESS | 1680 | 05:13:26 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 05:13:26 INFO - PROCESS | 1680 | RSS: Main: 280694784 05:13:26 INFO - PROCESS | 1680 | 05:13:28 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 05:13:29 INFO - PROCESS | 1680 | RSS: Main: 281899008 05:13:29 INFO - PROCESS | 1680 | 05:13:31 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:31 INFO - PROCESS | 1680 | RSS: Main: 280444928 05:13:31 INFO - PROCESS | 1680 | 05:13:34 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:35 INFO - PROCESS | 1680 | RSS: Main: 283213824 05:13:35 INFO - PROCESS | 1680 | 05:13:38 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:38 INFO - PROCESS | 1680 | RSS: Main: 283836416 05:13:38 INFO - PROCESS | 1680 | 05:13:42 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 05:13:42 INFO - PROCESS | 1680 | RSS: Main: 283283456 05:13:42 INFO - PROCESS | 1680 | 05:13:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:44 INFO - PROCESS | 1680 | RSS: Main: 283947008 05:13:44 INFO - PROCESS | 1680 | 05:13:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:47 INFO - PROCESS | 1680 | RSS: Main: 282996736 05:13:47 INFO - PROCESS | 1680 | 05:13:49 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:50 INFO - PROCESS | 1680 | RSS: Main: 283029504 05:13:50 INFO - PROCESS | 1680 | 05:13:52 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:53 INFO - PROCESS | 1680 | RSS: Main: 282710016 05:13:53 INFO - PROCESS | 1680 | 05:13:55 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:56 INFO - PROCESS | 1680 | RSS: Main: 283652096 05:13:56 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 05:13:58 INFO - PROCESS | 1680 | RSS: Main: 285491200 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | __start_tp_report 05:13:58 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 05:13:58 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 05:13:58 INFO - PROCESS | 1680 | |i|pagename|runs| 05:13:58 INFO - PROCESS | 1680 | |0;ai-astar;114;109;137;164;162;127;114;114;115;114 05:13:58 INFO - PROCESS | 1680 | |1;audio-beat-detection;154;119;137;152;119;135;120;153;147;120 05:13:58 INFO - PROCESS | 1680 | |2;audio-dft;197;195;193;215;187;242;176;251;190;266 05:13:58 INFO - PROCESS | 1680 | |3;audio-fft;57;55;66;68;71;116;68;53;61;57 05:13:58 INFO - PROCESS | 1680 | |4;audio-oscillator;84;88;124;111;115;98;120;79;108;162 05:13:58 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;89;87;89;86;89;86;93;116;90;86 05:13:58 INFO - PROCESS | 1680 | |6;imaging-darkroom;95;96;95;121;148;118;95;94;95;95 05:13:58 INFO - PROCESS | 1680 | |7;imaging-desaturate;93;82;151;150;124;92;124;147;148;100 05:13:58 INFO - PROCESS | 1680 | |8;json-parse-financial;57;59;61;84;87;86;83;95;58;53 05:13:58 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;64;70;63;76;72;74;68;60;66;76 05:13:58 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;85;84;84;85;82;86;87;101;114;112 05:13:58 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;138;126;134;129;138;137;134;108;110;136 05:13:58 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;129;141;126;161;185;144;146;133;141;130 05:13:58 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;67;75;98;93;85;69;66;69;67;68 05:13:58 INFO - PROCESS | 1680 | __end_tp_report 05:13:58 INFO - PROCESS | 1680 | __start_cc_report 05:13:58 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,957 05:13:58 INFO - PROCESS | 1680 | __end_cc_report 05:13:58 INFO - PROCESS | 1680 | __startTimestamp1457529238556__endTimestamp 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | ------- Summary: start ------- 05:13:58 INFO - PROCESS | 1680 | Number of tests: 14 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:127.00 Median:121.00 stddev:20.65 (17.1%) stddev-sans-first:21.36 05:13:58 INFO - PROCESS | 1680 | Values: 114.0 109.0 137.0 164.0 162.0 127.0 114.0 114.0 115.0 114.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:142.00 stddev:15.20 (10.7%) stddev-sans-first:14.60 05:13:58 INFO - PROCESS | 1680 | Values: 154.0 119.0 137.0 152.0 119.0 135.0 120.0 153.0 147.0 120.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:211.20 Median:206.00 stddev:30.95 (15.0%) stddev-sans-first:32.40 05:13:58 INFO - PROCESS | 1680 | Values: 197.0 195.0 193.0 215.0 187.0 242.0 176.0 251.0 190.0 266.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:67.20 Median:63.50 stddev:18.24 (28.7%) stddev-sans-first:18.97 05:13:58 INFO - PROCESS | 1680 | Values: 57.0 55.0 66.0 68.0 71.0 116.0 68.0 53.0 61.0 57.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:120.50 stddev:24.23 (20.1%) stddev-sans-first:23.96 05:13:58 INFO - PROCESS | 1680 | Values: 84.0 88.0 124.0 111.0 115.0 98.0 120.0 79.0 108.0 162.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:91.10 Median:89.00 stddev:9.02 (10.1%) stddev-sans-first:9.54 05:13:58 INFO - PROCESS | 1680 | Values: 89.0 87.0 89.0 86.0 89.0 86.0 93.0 116.0 90.0 86.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:95.00 stddev:18.18 (19.1%) stddev-sans-first:18.91 05:13:58 INFO - PROCESS | 1680 | Values: 95.0 96.0 95.0 121.0 148.0 118.0 95.0 94.0 95.0 95.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:121.10 Median:150.50 stddev:27.39 (18.2%) stddev-sans-first:27.10 05:13:58 INFO - PROCESS | 1680 | Values: 93.0 82.0 151.0 150.0 124.0 92.0 124.0 147.0 148.0 100.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:72.30 Median:83.50 stddev:15.94 (19.1%) stddev-sans-first:15.91 05:13:58 INFO - PROCESS | 1680 | Values: 57.0 59.0 61.0 84.0 87.0 86.0 83.0 95.0 58.0 53.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:71.00 stddev:5.63 (7.9%) stddev-sans-first:5.68 05:13:58 INFO - PROCESS | 1680 | Values: 64.0 70.0 63.0 76.0 72.0 74.0 68.0 60.0 66.0 76.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:84.50 stddev:12.26 (14.5%) stddev-sans-first:12.74 05:13:58 INFO - PROCESS | 1680 | Values: 85.0 84.0 84.0 85.0 82.0 86.0 87.0 101.0 114.0 112.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:135.00 stddev:11.23 (8.3%) stddev-sans-first:11.43 05:13:58 INFO - PROCESS | 1680 | Values: 138.0 126.0 134.0 129.0 138.0 137.0 134.0 108.0 110.0 136.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:142.50 stddev:17.82 (12.5%) stddev-sans-first:18.10 05:13:58 INFO - PROCESS | 1680 | Values: 129.0 141.0 126.0 161.0 185.0 144.0 146.0 133.0 141.0 130.0 05:13:58 INFO - PROCESS | 1680 | 05:13:58 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:72.00 stddev:11.92 (16.6%) stddev-sans-first:12.22 05:13:58 INFO - PROCESS | 1680 | Values: 67.0 75.0 98.0 93.0 85.0 69.0 66.0 69.0 67.0 68.0 05:13:58 INFO - PROCESS | 1680 | -------- Summary: end -------- 05:13:58 INFO - PROCESS | 1680 | 05:13:59 INFO - TEST-INFO | 1680: exit 0 05:13:59 INFO - TEST-OK | kraken | took 58665ms 05:13:59 INFO - SUITE-END | took 1170s 05:13:59 INFO - Completed test suite (00:19:30) 05:13:59 INFO - javascript benchmark 05:13:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2868.2542538939883, 3513.6662017108374, 3517.3668739626855, 3550.6271841456646, 3592.0840185752645, 5737.2541569596, 5738.483536481715, 5768.1059435787465, 5776.39347868474, 5788.739506722197, 5693.202951586771, 5703.914441283374, 5768.480836724694, 5855.677937713434, 5983.850403739909, 5224.111900976834, 5254.81608143715, 5282.7358632068435, 5295.655782374133, 5305.628605997563, 5329.0, 5347.46525347466, 5365.946340536584, 5394.0, 5394.271773310612, 5208.531232189102, 5249.658772179834, 5337.946620533784, 5338.439463856317, 5355.571554275649, 5255.842324730264, 5267.86830329241, 5298.337707786527, 5331.626786124973, 5368.00691872005, 5157.5616072633875, 5240.0567897778765, 5268.078086334915, 5279.9208011879855, 5328.8401347959625, 5673.23411339468, 5719.3422756382715, 5766.0, 5780.797672081457, 5816.272965879265, 5188.0, 6182.319944806068, 6211.9068213976825, 6239.313675495737, 6258.71835767387, 6133.763142530635, 6176.104464852571, 6200.534959878028, 6220.720067596969, 6247.187865577492, 5190.766415511311, 5693.743781529841, 5768.480836724715, 5988.401159884064, 5992.490638295793, 6358.682065896686, 6378.425941665272, 6386.584871983307, 6400.647964362005, 6411.67941602918, 6107.0, 6179.196704428396, 6210.192674952227, 6224.875502489925, 6288.371162883675, 6102.542309326729, 6164.4760195383, 6218.782342617987, 6228.065790131516, 6228.781992630236, 6174.135621013062, 6201.596896201732, 6218.440340369389, 6233.189685340877, 6247.406496382836, 6120.0205129226715, 6150.630962142286, 6177.4749146322165, 6194.34959329273, 6254.21822272216, 4946.1344264753525, 4993.80024799004, 4999.75001249936, 5020.799168033311, 5026.321446604735, 4479.59683628475, 4489.057297967398, 4494.438195225597, 4518.71216703238, 4544.136614043321, 5065.848024559269, 5871.794487192928, 5915.3788852170765, 5945.910811337833, 6040.244969378828, 6242.1261023456755, 6273.247210334789, 6279.560430769893, 6279.623222606567, 6302.684865756693, 5817.7382017809305, 6009.969950150221, 6019.939800602026, 6021.397860214031, 6043.153958445821, 4763.190257656207, 5442.102053161263, 5448.318960129984, 5468.808591699351, 5503.064479038573, 5721.342045664718, 6110.602810817282, 6443.1946006750095, 6451.741930322828, 6488.351164883474, 6123.953766440777, 6164.106204600397, 6290.622562646256, 6291.874162516816, 6307.463865571478, 6399.456046236122, 6449.838754031187, 6506.967465162644, 6517.055027020961, 6536.281009088902, 4899.706017638953, 5118.9506151238165, 5927.081302398135, 6158.199434073542, 6193.783217587363, 5288.524032837063, 5660.264165658438, 5777.45114214149, 6241.251049874044, 6297.338779428094, 6091.664958427329, 6139.706800529493, 6191.81424557264, 6199.783007594712, 6230.283517395376, 6118.174046503665, 6171.9074213887725, 6174.413430724074, 6213.596116252429, 6214.130021796862, 5804.477597016289, 6031.185789918481, 6066.817995460143, 6082.72627731762, 6094.0, 5649.745761440663, 5729.882672878749, 6116.579253789288, 6138.785142519991, 6190.50475961913, 6090.208272924491, 6126.693665316806, 6132.356102609162, 6146.754129834757, 6146.969265153824], "unit": "score", "name": "dojo.html", "value": 5722.541217696564}, {"lowerIsBetter": false, "replicates": [461.9699719518233, 569.4305694305693, 595.7438301530345, 605.142218357968, 642.5887432043492, 32367.028989130333, 38760.61239387605, 38784.0, 38902.44390224391, 39100.80449597748, 42448.57551424485, 42512.57487425125, 42690.0, 42823.0, 42886.92782680435, 9527.19018883394, 9748.463834489101, 9761.170300524464, 9770.609175632966, 9771.706848794547, 9659.5170241488, 9768.462734549597, 9791.804163916753, 9823.0, 9827.950860245688, 9735.75660608487, 9782.26633002524, 9831.901680983206, 9844.803103937917, 9855.211583073373, 9639.855402168972, 9696.0788725071, 9773.902260977371, 9786.608535658565, 9798.216142708601, 9586.185174260196, 9635.759106022335, 9694.75763105928, 9695.0, 9723.90276097237, 33089.6691033089, 40034.19931601381, 40212.994675133064, 40253.39619905704, 40537.391939120935, 3113.143885431502, 3254.08885512057, 3291.243014106769, 3377.4258376076127, 3490.2670439207795, 23275.883620581957, 28883.555822209015, 29427.411451770844, 30007.399852002836, 30129.397412051636, 2805.1724741201397, 2815.563587643898, 2850.330172409482, 2916.2271997920566, 2973.940521189564, 513226.0, 516931.0, 525335.0, 525698.9999999962, 526899.0, 46092.53907460949, 48009.5199048012, 75836.62081689667, 76589.0, 76753.0, 48246.79383015453, 48338.0, 48404.789880252574, 48648.78378040577, 48738.512614874104, 15706.921465392828, 15848.44530441429, 15880.364785408454, 15915.840841591667, 16004.439844605384, 12509.687257818627, 12516.624501264976, 12536.623901282976, 12702.047346449053, 12733.426995785212, 15303.540893773205, 15388.769168462482, 15443.922780386027, 15619.453319133776, 16045.839541604668, 5918.615290006136, 7030.332118448841, 7038.436925045984, 7093.538919970186, 7437.628118594049, 815.5514467043103, 861.8922634670666, 876.7390482256229, 1001.234055947201, 1024.6413755185774, 29686.406271874443, 29819.80720771145, 29948.0, 30236.84881575622, 30353.848230759148, 1041.3543602966058, 1119.5857532712948, 1154.543955137716, 1161.7676464707092, 1174.8766379530027, 15304.99186488723, 15361.385544578316, 15375.384984600714, 15438.996465229724, 15615.453459129103, 533205.0, 537747.0, 542715.0, 543258.0, 544147.0, 52288.73855630698, 55052.0, 61457.0, 61596.38403615996, 61836.0, 1439.359485029152, 1445.4001589340517, 1454.919979401143, 1460.715160543705, 1590.7852439920694, 28551.857240713663, 29667.258318542208, 29830.403391931606, 30029.24926876758, 30046.09861704065, 52966.205506918195, 54220.186697198784, 54526.0, 54817.0, 54923.450765493435, 481455.0, 495915.0, 497900.0, 498488.0, 499494.0, 34901.47647785336, 35255.82372088123, 35348.46977295394, 35850.46224306586, 44749.776251118536, 44274.77862610795, 44401.11197775962, 44919.0, 44996.55003450054, 45187.54812451833, 37085.88742337734, 37274.813625931696, 37516.43725344176, 37566.812165938994, 38490.498117622265, 37492.62507374891, 37732.46695048218, 37753.867383978526, 38306.23387532178, 38581.2283754329, 32052.83973580117, 37238.0, 37263.06842328963, 38138.618613814615, 38488.80755596204, 27936.161915142577, 33679.98960031203, 33730.66269337275, 33953.83023084869, 34766.47850282197, 24282.514349712554, 24322.391940201636, 24742.0, 24802.50394992126, 24834.503309933338], "unit": "score", "name": "ext.html", "value": 19663.238943040404}, {"lowerIsBetter": false, "replicates": [359.99999999999983, 365.2986266368572, 370.9276691045246, 375.6487684015446, 376.78334957399466, 15660.21698915054, 17270.827291727095, 18066.458006259818, 19921.0, 19936.003199840023, 20705.482362940897, 21327.933603319812, 21388.57222855542, 21551.245706400277, 21557.1377144914, 5567.66594004359, 5763.164341170528, 5848.385919478457, 5865.237519122508, 5878.177055212273, 5592.238444889867, 5696.914546281809, 5712.2574065371655, 5796.913046304308, 5799.681017544033, 5037.29477873098, 5562.137868630369, 5595.076812325961, 5731.570132240078, 5750.856228594277, 5518.668879867221, 5581.330240371161, 5598.048331783607, 5674.347450043257, 5706.914396284038, 4904.705717656916, 4919.11455937931, 4929.014197160583, 4929.137400954819, 4940.110780059588, 19188.520286992796, 20163.99180040992, 25429.98280068795, 25459.745402545923, 25695.61456578153, 2110.947226319339, 2221.955560888773, 2243.461569223391, 2253.6056190166655, 2270.14869423966, 14472.782908256384, 14648.340824662915, 15135.243237838175, 15164.090154590649, 15416.3833446662, 1778.0754007915941, 1799.8650101242329, 1823.188681036939, 1845.335679155503, 1863.515485973643, 88599.67100493498, 103486.0, 106715.0, 108867.0, 109283.81432371387, 10201.744956376002, 10734.624288149877, 10742.194335424874, 10862.565497380016, 10896.891031089588, 12718.618441446772, 12827.743445131046, 12905.35473226335, 12905.935470322589, 12906.354682266037, 8431.409801313972, 8459.70391036323, 8471.025832029272, 8494.277986371104, 8569.928758905136, 8665.696700615448, 8690.174433428814, 8698.60856261457, 8786.384953053224, 8797.956010219908, 6277.05844123376, 6303.338149494237, 6311.621302721851, 6343.5876668016435, 6349.301576826545, 1867.4957761404344, 1899.4206766936218, 1904.961900761977, 1904.9904750476437, 1911.9866470770514, 929.4562680831789, 953.0183910572122, 969.8496733006396, 1008.621766837436, 1081.9242653014371, 19814.306499272458, 20397.592048158953, 20753.782286908925, 21537.784622153893, 21577.892110539346, 969.1374676537887, 991.0832479956156, 1032.5972870580479, 1063.7340664833791, 1072.8873468285874, 11008.779824403468, 11385.715357116138, 11444.0, 11446.828297575543, 11465.71335716597, 630340.0, 630636.0, 636374.0, 658288.0, 692801.0, 85974.0, 92272.53863730638, 94810.0, 99597.0, 104404.0, 1022.1158697726413, 1026.14829691356, 1045.7019749371545, 1054.615065501102, 1058.349115294104, 18624.348147814762, 19075.332363367215, 19177.32879349216, 19196.808031919503, 19506.609867802847, 49054.75472622614, 50600.240996384346, 50889.745551272004, 51926.480735193676, 53216.46783532115, 63222.0, 63814.08557743275, 65463.0, 66583.67952967298, 69841.0, 7728.304452599293, 7738.806529836799, 7832.373410127062, 7928.920710792819, 7950.324222441157, 12963.287019214034, 13028.5440009603, 13086.345682716017, 13350.465981360638, 13513.0, 11198.272112312674, 11344.262622929813, 11462.541498339973, 11487.770244595229, 11494.137939654393, 11117.722056948318, 11125.666230012788, 11164.944175279072, 11455.942720286344, 11458.140639452242, 11473.82789258145, 11483.712907177052, 11562.248453850472, 11732.589359372723, 11990.280583165038, 7639.159692433716, 7813.02337207849, 7832.412569057229, 7847.136814950465, 8028.554860125234, 8747.781305467413, 9549.28380371461, 11057.61298354586, 11261.268017578832, 11382.317060976036], "unit": "score", "name": "jquery.html", "value": 9506.389768580992}, {"lowerIsBetter": false, "replicates": [1604.7031299209648, 1617.5794293483693, 1675.6983742926268, 2007.498125468632, 2014.0835919656558, 7921.326687231578, 8689.435186712875, 8872.955635221822, 9096.999330073686, 9189.632414703412, 8795.692150774725, 8808.207261346477, 8841.292696584274, 8846.0, 8853.5573221339, 2440.2313271319567, 2467.2968204061845, 2467.3338198686342, 2471.5180539794746, 2475.4801491686767, 1896.5163883209832, 2094.2042024030848, 2382.28531440568, 2490.7633774791366, 2495.263897150336, 2463.08865719684, 2475.158446128316, 2491.1530079772874, 2500.299916023507, 2504.5742223821903, 2457.5330687169558, 2458.053649344997, 2459.385153711572, 2462.0151939224365, 2486.167134010109, 2215.4129155773735, 2393.6236663918144, 2446.1805295226122, 2459.5449841779327, 2481.8634975076366, 8851.070637583025, 8891.73324800257, 8916.643334266622, 8941.329400295004, 8970.910290897073, 5394.757235924393, 5521.944780552183, 5533.6956467394275, 5540.612157149001, 5572.247746554204, 3571.4464258040043, 3671.504346913186, 3673.9265214695824, 3683.355412802749, 3708.035910663247, 1044.9791004179874, 1067.7757670889123, 1069.0645685025602, 1076.4994277660846, 1078.9730256743567, 12000.579979700757, 12016.0, 12182.329971851634, 12187.45156467961, 12292.877071229352, 4892.437369702458, 4911.017796440726, 4966.6771659842, 5005.249212618136, 5027.572656324253, 10148.898511014795, 10247.026532479402, 10247.333923295111, 10264.127549158406, 10274.33216840903, 5505.256790333254, 5523.392426833045, 5525.4474552545225, 5536.557075433956, 5536.667799932017, 4460.732356058582, 4975.900481990412, 4993.7503124843615, 4993.825216117419, 5027.497250275016, 3916.8824935251987, 3944.6647035002347, 3973.960260397359, 4002.399640054015, 4044.716869819143, 1345.9730805384033, 1350.2506109109538, 1365.7336819320335, 1366.269046060353, 1379.717157982611, 1365.9726805463836, 1373.7252549490142, 1397.6925076483158, 1402.1236727045596, 1414.3918115210352, 8139.30815880645, 8180.100188979208, 8198.672053117927, 8341.749747507585, 8379.162083791573, 523.7486006716797, 533.3040382301057, 534.6284332388952, 538.3485981961792, 539.1131588536913, 6194.4115309045565, 6207.0, 6219.751209951552, 6267.592606480655, 6290.433860952537, 10592.894071059345, 10726.678199654023, 10897.128229741602, 10988.340699558052, 11165.497552610152, 10525.9473702631, 10565.788684226272, 10592.205584581186, 10752.462376881125, 10800.78398432027, 8459.0, 8479.95760021196, 8515.872261916076, 8590.269827064645, 8634.784130396665, 7808.063032436144, 7815.882761758465, 7861.371090312647, 7982.401319900914, 8069.193080691884, 9471.952640236756, 9611.519424028911, 9611.807763844823, 9656.903430965882, 9718.611255549698, 9632.084951929555, 9718.757031073997, 9998.500074996076, 10061.949690251502, 10152.746181345525, 5530.169306118486, 7183.568985860865, 7344.155422126524, 7539.547627142389, 7615.5430674159725, 8004.439689221931, 8095.352371810123, 8185.959070204611, 8200.138985406686, 8256.215659512336, 6438.581492202992, 7341.889871652036, 7374.852502950018, 7458.73894413693, 7540.132884718328, 5635.619273278073, 7102.112235970504, 7198.280171982759, 7274.563526188445, 7411.444141689287, 7466.36535894455, 7590.0, 7623.313901748647, 7707.075150981918, 7773.0, 7069.858602827811, 7076.681549330189, 7079.82300442493, 7104.431645468247, 7140.321669441395, 5784.363719990882, 6136.846578835565, 7002.719891204295, 7080.610566418896, 7227.638618069181], "unit": "score", "name": "mootools.html", "value": 4873.841281942801}, {"lowerIsBetter": false, "replicates": [280.62396388838954, 328.8355822088956, 329.53041915270734, 332.2043705325745, 338.2355875720872, 6844.726210951562, 6926.792196234115, 6944.375006249436, 6945.270746571613, 6966.5820050796865, 6805.523613347068, 6905.343992320734, 6949.756758513453, 6969.651517424121, 6989.370956613904, 4896.387951506062, 4975.12935236334, 5121.462246464123, 5125.3342663634285, 5154.536091751742, 3893.0, 4463.575960283768, 5080.695158290496, 5106.131957567222, 5121.590272778169, 4061.6547593454593, 5006.699598024112, 5027.84916452507, 5027.899442011176, 5045.747712614373, 5043.873903152432, 5085.542301192911, 5093.0577843099145, 5093.414257360396, 5099.617528685345, 3614.331348700499, 4353.673474489426, 4356.607905288539, 4362.36745671879, 4365.7817109144735, 5440.347158341025, 6360.55476116672, 6678.9332106679285, 6711.798646040626, 6728.058071869942, 5823.068309070529, 5863.149843272701, 5898.817437548135, 5908.350081491032, 5916.763329466816, 7353.30143636359, 7353.558786472775, 7357.264273572653, 7358.190599034102, 7381.224971378036, 4650.395448591696, 4674.228752255874, 4675.275332323461, 4684.8360307389075, 4693.084848454553, 7746.612669366566, 7798.167430653849, 7810.140884502757, 7827.3346765525, 7827.765167044998, 4503.662225333113, 4544.7727613619845, 4631.6294696424875, 4698.459677137104, 4705.12955103307, 4773.809047638125, 4776.761161941889, 4785.186518291899, 4785.617150627942, 4806.735629540339, 4654.790534425959, 4654.999175177353, 4723.834665786681, 5337.092694241988, 5821.88356232873, 6309.621422714652, 7316.6341682915645, 7323.450741194431, 7338.963305183546, 7363.226861179606, 1647.398699474707, 1664.758610001543, 1669.2154687296952, 1669.933202671904, 1682.1841406917636, 973.8557195295499, 989.6387818446216, 998.2812375089924, 1063.3088492479949, 1082.7996820588216, 6814.522983391115, 6895.655217239118, 6910.516263861582, 6918.273581273995, 6927.411170050602, 6884.931150688529, 7585.734499292498, 7638.350740187147, 7641.35048520882, 7647.923520764833, 6833.350831670983, 6862.416694580917, 6878.965605171942, 6893.551919125241, 6913.274106218875, 3912.8434862605745, 3923.7253392262837, 4011.618896204856, 4030.536488303824, 4038.919221615551, 7856.450048496665, 7999.880001799977, 8028.996375453068, 8046.959765201136, 8092.069412017576, 7943.960280198562, 7995.2804247618, 8003.799905002422, 8011.679532818622, 8012.0, 6487.54587178893, 8060.637271322687, 8063.758087257392, 8072.031356237172, 8102.4733392328135, 7456.55260684339, 7716.459847810599, 7717.2668596483245, 7731.149573546792, 7753.37972962173, 7482.588457634883, 7518.586477743558, 7631.771046868603, 7638.694452221849, 7650.579218142833, 8121.75634730959, 8123.0658474276215, 8142.267195952392, 8145.307648849915, 8160.673573057011, 4738.455077666113, 4775.5463230993, 4779.665423420327, 4780.521947805191, 4788.4253889533475, 7540.245975402416, 7716.459847810599, 7748.57382843949, 7750.534967901944, 7759.301662850145, 7344.339009489172, 7396.149442814145, 7414.518056326321, 7434.925650743423, 7436.405087593088, 7393.852122957618, 7399.482036257626, 7403.185649578434, 7413.592252426169, 7451.441141914486, 6929.0, 7189.460790440633, 7203.783886483414, 7221.205667376479, 7264.818379540554, 7363.153237377556, 7403.222661620668, 7407.370373518312, 7429.257074292527, 7434.516756410816, 5844.795432159854, 5864.794732184353, 6123.785667501795, 6407.711652975534, 7253.891191632235], "unit": "score", "name": "prototype.html", "value": 5298.006698366082}, {"lowerIsBetter": false, "replicates": [717.748598847222, 725.8584576007679, 726.7129483853878, 764.8393837294168, 782.0966783365211, 14873.107613543196, 15156.1664108474, 15380.846191538081, 15383.077015379085, 15431.07413555186, 14380.49668261611, 14495.275236238198, 14497.057691250062, 14573.271336433163, 14780.556583302518, 773.2731232641328, 934.5140526926011, 949.7957939043105, 964.5129209749067, 965.8985806490323, 928.1924725488834, 953.7615596100975, 956.8803899512561, 958.1185309515263, 959.0984474593894, 1007.4308015970989, 1012.696191142658, 1014.985014985015, 1015.3501758874327, 1016.1464369929258, 979.8628192053083, 986.5461887531673, 1004.8442491413842, 1008.5108722269694, 1009.0262896305064, 716.8745469542861, 727.8253219227347, 730.9853802923965, 749.7375918428561, 751.3763576231714, 14890.329935152835, 14898.627534311621, 15100.697986040328, 15285.929984901062, 15288.159151246677, 12954.870451295461, 12967.740645187137, 13009.674758131028, 13111.0, 13169.670758231025, 8379.49723016621, 9961.628469779318, 9965.850512242323, 9981.726815897648, 10055.195584353234, 3462.23830757233, 3486.703630191437, 3497.143199916037, 3546.148924258185, 3607.062163837395, 78271.0, 78666.6066669663, 80113.59943200246, 81928.0, 82213.58893205496, 8008.719694810654, 9427.575759090858, 9548.1884039856, 9549.952250238704, 9628.0, 21984.90075496219, 22063.66904496434, 22074.66887996681, 22101.33695989123, 22142.114315427523, 7561.168271490132, 7647.961760191275, 7702.73040443593, 7715.652795624211, 7785.1436342002335, 4041.4948131483566, 4074.368472886648, 4163.2298024864895, 4164.4586203793315, 4165.354370072643, 3523.2248905241318, 3525.9471107932886, 3532.2229109595846, 3552.982235088808, 3577.767445116059, 638.7125793392992, 656.0716586030713, 656.8259411256021, 658.6607896933083, 660.0594153331483, 548.7530611224964, 586.2818047891384, 602.2682440834408, 608.0392979093023, 611.119987218404, 8070.192980701883, 8213.425060245845, 8326.375521835887, 8359.331253499706, 8437.704680336281, 539.0405078959459, 592.1059200607115, 615.7506209984963, 616.0, 632.9746810127635, 3800.2969450651717, 3855.9614403856162, 3942.5071866016747, 3983.6215559521797, 3988.760674359548, 73557.6322118386, 73599.63200184071, 73865.0, 73899.63050184715, 78747.0, 37449.43825842615, 56738.14892776612, 58061.8387632245, 58672.0, 59441.10838337428, 49658.255126173855, 64482.0, 65127.67436162789, 65780.0, 65911.34088659148, 8046.879296810435, 8285.295749861329, 8421.70524031656, 8448.028476725256, 8509.702160424355, 44873.77563112294, 47773.0, 51775.74112129415, 52316.73841630767, 56469.0, 56250.0, 63926.04110938433, 71080.28919710944, 71746.0, 74161.25838741759, 10371.844422333821, 10405.375677459377, 11355.659330220107, 11574.18980671345, 11607.825882611598, 8838.734837954871, 11232.438378081226, 12081.577144800242, 12102.0, 12522.0, 9121.589528471102, 10793.67618971432, 11289.491972861406, 11342.546298147981, 11866.584669536525, 11604.535818567163, 11608.825867612162, 11852.52589896429, 12004.519819207135, 12072.75854482888, 11308.886911131112, 11404.087672985976, 11711.180217385043, 11725.530978760755, 11729.765404691687, 9346.439213647203, 9632.662856799978, 9640.373375730554, 9715.0, 9844.40933543961, 9694.0, 9781.364211326241, 9788.168005719594, 9809.460479673686, 9870.358426702529], "unit": "score", "name": "yui.html", "value": 6856.771543741976}], "name": "dromaeo_css", "value": 7578.202948848047}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 137.0, 164.0, 162.0, 127.0, 114.0, 114.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 127.0}, {"lowerIsBetter": true, "replicates": [154.0, 119.0, 137.0, 152.0, 119.0, 135.0, 120.0, 153.0, 147.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 135.6}, {"lowerIsBetter": true, "replicates": [197.0, 195.0, 193.0, 215.0, 187.0, 242.0, 176.0, 251.0, 190.0, 266.0], "unit": "score", "name": "audio-dft", "value": 211.2}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 66.0, 68.0, 71.0, 116.0, 68.0, 53.0, 61.0, 57.0], "unit": "score", "name": "audio-fft", "value": 67.2}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 124.0, 111.0, 115.0, 98.0, 120.0, 79.0, 108.0, 162.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 89.0, 86.0, 89.0, 86.0, 93.0, 116.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 121.0, 148.0, 118.0, 95.0, 94.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 105.2}, {"lowerIsBetter": true, "replicates": [93.0, 82.0, 151.0, 150.0, 124.0, 92.0, 124.0, 147.0, 148.0, 100.0], "unit": "score", "name": "imaging-desaturate", "value": 121.1}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 61.0, 84.0, 87.0, 86.0, 83.0, 95.0, 58.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 72.3}, {"lowerIsBetter": true, "replicates": [64.0, 70.0, 63.0, 76.0, 72.0, 74.0, 68.0, 60.0, 66.0, 76.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 84.0, 85.0, 82.0, 86.0, 87.0, 101.0, 114.0, 112.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.0}, {"lowerIsBetter": true, "replicates": [138.0, 126.0, 134.0, 129.0, 138.0, 137.0, 134.0, 108.0, 110.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.0}, {"lowerIsBetter": true, "replicates": [129.0, 141.0, 126.0, 161.0, 185.0, 144.0, 146.0, 133.0, 141.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [67.0, 75.0, 98.0, 93.0, 85.0, 69.0, 66.0, 69.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.7}], "name": "kraken", "value": 1548.8000000000002}]} 05:13:59 INFO - Return code: 0 05:13:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:13:59 ERROR - # TBPL SUCCESS # 05:13:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:13:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:13:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:13:59 INFO - 2016-03-09 05:13:59.886 screenresolution[1685:10870] starting screenresolution argv=screenresolution get 05:13:59 INFO - 2016-03-09 05:13:59.889 screenresolution[1685:10870] Display 0: 1600x1200x32@60 05:13:59 INFO - 2016-03-09 05:13:59.896 screenresolution[1686:10873] starting screenresolution argv=screenresolution list 05:13:59 INFO - Available Modes on Display 0 05:13:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:13:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:13:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:13:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:14:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:14:00 INFO - Intel Iris: 05:14:00 INFO - Chipset Model: Intel Iris 05:14:00 INFO - Type: GPU 05:14:00 INFO - Bus: Built-In 05:14:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:14:00 INFO - Vendor: Intel (0x8086) 05:14:00 INFO - Device ID: 0x0a2e 05:14:00 INFO - Revision ID: 0x0009 05:14:00 INFO - Displays: 05:14:00 INFO - Display: 05:14:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:14:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:14:00 INFO - Display Serial Number: 1600x1200 60 05:14:00 INFO - Main Display: Yes 05:14:00 INFO - Mirror: Off 05:14:00 INFO - Online: Yes 05:14:00 INFO - Rotation: Supported 05:14:00 INFO - Return code: 0 05:14:00 INFO - Running post-action listener: _resource_record_post_action 05:14:00 INFO - Running post-run listener: _resource_record_post_run 05:14:01 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 39503360; Write bytes: 705328128; Read time: 425; Write time: 1895 05:14:01 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 386894336; Write bytes: 380528128; Read time: 28818; Write time: 657 05:14:01 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 38569472; Write bytes: 302075392; Read time: 412; Write time: 1184 05:14:01 INFO - Running post-run listener: _upload_blobber_files 05:14:01 INFO - Blob upload gear active. 05:14:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:14:01 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:14:01 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:14:01 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:14:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:14:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:14:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:14:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:05 INFO - (blobuploader) - INFO - Done attempting. 05:14:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:14:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:14:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:14:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:14:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:14:07 INFO - (blobuploader) - INFO - Done attempting. 05:14:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:14:07 INFO - Return code: 0 05:14:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:14:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:14:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2010c10233f5b8d905d50bd1b4caa5befbd5332a406bc142f05eb2a8b00ea377a886b8f1eface53fab0f910133ed2dd60fe513feda65cf9ac8e2628fae7f4bc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9574a61d645d8a3b0eef0c7368f98f7a1d7c4981d736eea82523a3d918a28421a414b099b713231bba600aba7c26beaba498696751c3cf62407b8aa57ecc378"} 05:14:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:14:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:14:07 INFO - Contents: 05:14:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2010c10233f5b8d905d50bd1b4caa5befbd5332a406bc142f05eb2a8b00ea377a886b8f1eface53fab0f910133ed2dd60fe513feda65cf9ac8e2628fae7f4bc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9574a61d645d8a3b0eef0c7368f98f7a1d7c4981d736eea82523a3d918a28421a414b099b713231bba600aba7c26beaba498696751c3cf62407b8aa57ecc378"} 05:14:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:14:07 INFO - Copying logs to upload dir... 05:14:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:14:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.007047 ========= master_lag: 3.58 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-09 05:14:10.631856) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 6 secs) (at 2016-03-09 05:14:10.635990) ========= 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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2010c10233f5b8d905d50bd1b4caa5befbd5332a406bc142f05eb2a8b00ea377a886b8f1eface53fab0f910133ed2dd60fe513feda65cf9ac8e2628fae7f4bc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9574a61d645d8a3b0eef0c7368f98f7a1d7c4981d736eea82523a3d918a28421a414b099b713231bba600aba7c26beaba498696751c3cf62407b8aa57ecc378"} build_url:https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011044 build_url: 'https://queue.taskcluster.net/v1/task/anXJ84ziQ7qtWXEgYC047g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2010c10233f5b8d905d50bd1b4caa5befbd5332a406bc142f05eb2a8b00ea377a886b8f1eface53fab0f910133ed2dd60fe513feda65cf9ac8e2628fae7f4bc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9574a61d645d8a3b0eef0c7368f98f7a1d7c4981d736eea82523a3d918a28421a414b099b713231bba600aba7c26beaba498696751c3cf62407b8aa57ecc378"}' ========= master_lag: 6.96 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 6 secs) (at 2016-03-09 05:14:17.608642) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 05:14:17.608987) ========= 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.1ON4CV5u8o/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.tMfQ34dDCl/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.005279 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 05:14:17.650360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 05:14:17.650681) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 05:14:17.652259) ========= ========= Total master_lag: 21.96 =========