builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0044 starttime: 1457145075.12 results: success (0) buildid: 20160304155027 builduid: 9a416a62a1e54cb69a34497648f791f6 revision: 69d357fb6a0b38239b855a9aeea863d035f9fca5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.118249) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.118706) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.118993) ========= 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.DxQsqdX3jz/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.p621HLrCY6/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.005768 basedir: '/builds/slave/test' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.222271) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.225598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.338394) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.338737) ========= 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.DxQsqdX3jz/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.p621HLrCY6/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.005836 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.393321) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.396692) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.397078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.397361) ========= 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.DxQsqdX3jz/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.p621HLrCY6/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-04 18:31:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 70.2M=0s 2016-03-04 18:31:15 (70.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.520098 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.940474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.940880) ========= 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.DxQsqdX3jz/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.p621HLrCY6/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.026240 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:15.989225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-04 18:31:15.992662) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 69d357fb6a0b38239b855a9aeea863d035f9fca5 --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 69d357fb6a0b38239b855a9aeea863d035f9fca5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DxQsqdX3jz/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.p621HLrCY6/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-04 18:31:16,070 truncating revision to first 12 chars 2016-03-04 18:31:16,071 Setting DEBUG logging. 2016-03-04 18:31:16,071 attempt 1/10 2016-03-04 18:31:16,071 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/69d357fb6a0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 18:31:17,108 unpacking tar archive at: fx-team-69d357fb6a0b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.290114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-04 18:31:17.298854) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:17.299185) ========= echo 69d357fb6a0b38239b855a9aeea863d035f9fca5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'69d357fb6a0b38239b855a9aeea863d035f9fca5'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DxQsqdX3jz/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.p621HLrCY6/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 69d357fb6a0b38239b855a9aeea863d035f9fca5 program finished with exit code 0 elapsedTime=0.005319 script_repo_revision: '69d357fb6a0b38239b855a9aeea863d035f9fca5' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:17.355569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:17.355877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 18:31:17.373091) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-04 18:31:17.373425) ========= /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.DxQsqdX3jz/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.p621HLrCY6/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 18:31:17 INFO - MultiFileLogger online at 20160304 18:31:17 in /builds/slave/test 18:31:17 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 18:31:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:31:17 INFO - {'append_to_log': False, 18:31:17 INFO - 'base_work_dir': '/builds/slave/test', 18:31:17 INFO - 'blob_upload_branch': 'Fx-Team', 18:31:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:31:17 INFO - 'branch': 'Fx-Team', 18:31:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:31:17 INFO - 'config_files': ('talos/mac_config.py',), 18:31:17 INFO - 'default_actions': ('clobber', 18:31:17 INFO - 'read-buildbot-config', 18:31:17 INFO - 'download-and-extract', 18:31:17 INFO - 'populate-webroot', 18:31:17 INFO - 'create-virtualenv', 18:31:17 INFO - 'install', 18:31:17 INFO - 'run-tests'), 18:31:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:31:17 INFO - 'download_minidump_stackwalk': True, 18:31:17 INFO - 'download_symbols': 'ondemand', 18:31:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:31:17 INFO - 'tooltool.py': '/tools/tooltool.py', 18:31:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:31:17 INFO - '/tools/misc-python/virtualenv.py')}, 18:31:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:31:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:31:17 INFO - 'installer_path': 'installer.exe', 18:31:17 INFO - 'log_level': 'info', 18:31:17 INFO - 'log_name': 'talos', 18:31:17 INFO - 'log_to_console': True, 18:31:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:31:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:31:17 INFO - 'opt_config_files': (), 18:31:17 INFO - 'pip_index': False, 18:31:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:31:17 INFO - 'cmd': ('bash', 18:31:17 INFO - '-c', 18:31:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:31:17 INFO - 'enabled': True, 18:31:17 INFO - 'halt_on_failure': False, 18:31:17 INFO - 'name': 'check_screen_resolution'},), 18:31:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:31:17 INFO - 'cmd': ('bash', 18:31:17 INFO - '-c', 18:31:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:31:17 INFO - 'enabled': True, 18:31:17 INFO - 'halt_on_failure': False, 18:31:17 INFO - 'name': 'check_screen_resolution'},), 18:31:17 INFO - 'run_cmd_checks_enabled': True, 18:31:17 INFO - 'sps_profile': False, 18:31:17 INFO - 'sps_profile_interval': 0, 18:31:17 INFO - 'suite': 'dromaeojs-e10s', 18:31:17 INFO - 'system_bits': '32', 18:31:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:31:17 INFO - 'title': 't-yosemite-r7-0044', 18:31:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:31:17 INFO - 'use_talos_json': True, 18:31:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:31:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:31:17 INFO - 'work_dir': 'build'} 18:31:17 INFO - ##### 18:31:17 INFO - ##### Running clobber step. 18:31:17 INFO - ##### 18:31:17 INFO - Running pre-action listener: _resource_record_pre_action 18:31:17 INFO - Running main action method: clobber 18:31:17 INFO - rmtree: /builds/slave/test/build 18:31:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:31:19 INFO - Running post-action listener: _resource_record_post_action 18:31:19 INFO - ##### 18:31:19 INFO - ##### Running read-buildbot-config step. 18:31:19 INFO - ##### 18:31:19 INFO - Running pre-action listener: _resource_record_pre_action 18:31:19 INFO - Running main action method: read_buildbot_config 18:31:19 INFO - Using buildbot properties: 18:31:19 INFO - { 18:31:19 INFO - "project": "", 18:31:19 INFO - "product": "firefox", 18:31:19 INFO - "script_repo_revision": "production", 18:31:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 18:31:19 INFO - "repository": "", 18:31:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 18:31:19 INFO - "buildid": "20160304155027", 18:31:19 INFO - "pgo_build": "False", 18:31:19 INFO - "basedir": "/builds/slave/test", 18:31:19 INFO - "buildnumber": 584, 18:31:19 INFO - "slavename": "t-yosemite-r7-0044", 18:31:19 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:31:19 INFO - "platform": "yosemite_r7", 18:31:19 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:31:19 INFO - "branch": "fx-team", 18:31:19 INFO - "repo_path": "integration/fx-team", 18:31:19 INFO - "revision": "69d357fb6a0b38239b855a9aeea863d035f9fca5", 18:31:19 INFO - "stage_platform": "macosx64", 18:31:19 INFO - "builduid": "9a416a62a1e54cb69a34497648f791f6", 18:31:19 INFO - "slavebuilddir": "test" 18:31:19 INFO - } 18:31:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 18:31:19 INFO - Running post-action listener: _resource_record_post_action 18:31:19 INFO - ##### 18:31:19 INFO - ##### Running download-and-extract step. 18:31:19 INFO - ##### 18:31:19 INFO - Running pre-action listener: _resource_record_pre_action 18:31:19 INFO - Running main action method: download_and_extract 18:31:19 INFO - mkdir: /builds/slave/test/build/tests 18:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:19 INFO - https://queue.taskcluster.net/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:31:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 18:31:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 18:31:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 18:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 18:31:20 INFO - Downloaded 1277 bytes. 18:31:20 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 18:31:20 INFO - Using the following test package requirements: 18:31:20 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:31:20 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:31:20 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 18:31:20 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:31:20 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 18:31:20 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:31:20 INFO - u'jsshell-mac.zip'], 18:31:20 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:31:20 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 18:31:20 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:31:20 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:31:20 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 18:31:20 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:31:20 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 18:31:20 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:31:20 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 18:31:20 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:31:20 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:31:20 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 18:31:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:20 INFO - https://queue.taskcluster.net/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:31:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:31:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:31:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:31:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:31:21 INFO - Downloaded 17860931 bytes. 18:31:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:31:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:31:24 INFO - Return code: 0 18:31:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:24 INFO - https://queue.taskcluster.net/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:31:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:31:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:31:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:31:25 INFO - Downloaded 17860931 bytes. 18:31:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:31:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:31:29 INFO - Return code: 0 18:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:29 INFO - https://queue.taskcluster.net/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:31:30 INFO - Downloaded 10803659 bytes. 18:31:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:31:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:31:30 INFO - Return code: 0 18:31: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')]} 18:31:30 INFO - https://queue.taskcluster.net/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:31:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:31:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:31:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 18:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 18:31:33 INFO - Downloaded 110938526 bytes. 18:31:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:31:33 INFO - mkdir: /builds/slave/test/properties 18:31:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:33 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:33 INFO - Contents: 18:31:33 INFO - build_url:https://queue.taskcluster.net/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:31:35 INFO - Running post-action listener: _resource_record_post_action 18:31:35 INFO - Running post-action listener: set_extra_try_arguments 18:31:35 INFO - ##### 18:31:35 INFO - ##### Running populate-webroot step. 18:31:35 INFO - ##### 18:31:35 INFO - Running pre-action listener: _resource_record_pre_action 18:31:35 INFO - Running main action method: populate_webroot 18:31:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:35 INFO - '--tppagecycles', 18:31:35 INFO - '7'], 18:31:35 INFO - 'tests': ['tsvgm']}}, 18:31:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:31:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:31:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:31:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:31:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:35 INFO - 'talos_options': ['--e10s'], 18:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:35 INFO - 'tests': ['damp', 'tps']}, 18:31:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:35 INFO - 'talos_options': ['--e10s'], 18:31:35 INFO - 'tests': ['damp', 'tps']}, 18:31:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:31:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:35 INFO - 'other': {'tests': ['a11yr', 18:31:35 INFO - 'ts_paint', 18:31:35 INFO - 'tpaint', 18:31:35 INFO - 'sessionrestore', 18:31:35 INFO - 'sessionrestore_no_auto_restore']}, 18:31:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:31:35 INFO - 'tests': ['a11yr', 18:31:35 INFO - 'ts_paint', 18:31:35 INFO - 'tpaint', 18:31:35 INFO - 'sessionrestore', 18:31:35 INFO - 'sessionrestore_no_auto_restore']}, 18:31:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:31:35 INFO - 'tests': ['a11yr', 18:31:35 INFO - 'ts_paint', 18:31:35 INFO - 'tpaint', 18:31:35 INFO - 'sessionrestore', 18:31:35 INFO - 'sessionrestore_no_auto_restore']}, 18:31:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:31:35 INFO - 'tests': ['a11yr', 18:31:35 INFO - 'ts_paint', 18:31:35 INFO - 'tpaint', 18:31:35 INFO - 'sessionrestore', 18:31:35 INFO - 'sessionrestore_no_auto_restore']}, 18:31:35 INFO - 'other_l64': {'tests': ['a11yr', 18:31:35 INFO - 'ts_paint', 18:31:35 INFO - 'tpaint', 18:31:35 INFO - 'sessionrestore', 18:31:35 INFO - 'sessionrestore_no_auto_restore']}, 18:31:35 INFO - 'other_nol64': {'tests': ['a11yr', 18:31:35 INFO - 'ts_paint', 18:31:35 INFO - 'tpaint', 18:31:35 INFO - 'sessionrestore', 18:31:35 INFO - 'sessionrestore_no_auto_restore']}, 18:31:35 INFO - 'svgr': {'tests': ['tsvgx', 18:31:35 INFO - 'tsvgr_opacity', 18:31:35 INFO - 'tart', 18:31:35 INFO - 'tscrollx', 18:31:35 INFO - 'cart']}, 18:31:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:31:35 INFO - 'tests': ['tsvgx', 18:31:35 INFO - 'tsvgr_opacity', 18:31:35 INFO - 'tart', 18:31:35 INFO - 'tscrollx', 18:31:35 INFO - 'cart']}, 18:31:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:35 INFO - 'tests': ['tp5o']}, 18:31:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:35 INFO - 'talos_options': ['--e10s'], 18:31:35 INFO - 'tests': ['tp5o']}, 18:31:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:35 INFO - 'talos_options': ['--xperf_path', 18:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:35 INFO - 'tests': ['tp5n']}, 18:31:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:35 INFO - 'talos_options': ['--e10s', 18:31:35 INFO - '--xperf_path', 18:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:35 INFO - 'tests': ['tp5n']}}, 18:31:35 INFO - 'talos.zip': {'path': '', 18:31:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:35 INFO - Running post-action listener: _resource_record_post_action 18:31:35 INFO - ##### 18:31:35 INFO - ##### Running create-virtualenv step. 18:31:35 INFO - ##### 18:31:35 INFO - Running pre-action listener: _resource_record_pre_action 18:31:35 INFO - Running main action method: create_virtualenv 18:31:35 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:35 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 18:31:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:35 INFO - Using real prefix '/tools/python27' 18:31:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:35 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:38 INFO - Installing pip.................done. 18:31:38 INFO - Return code: 0 18:31:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f9a59d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d084d30>, '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 0x10cea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07bb20>, '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.DxQsqdX3jz/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.p621HLrCY6/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 18:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:31:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DxQsqdX3jz/Render', 18:31:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:39 INFO - 'HOME': '/Users/cltbld', 18:31:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:39 INFO - 'LOGNAME': 'cltbld', 18:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:39 INFO - 'MOZ_NO_REMOTE': '1', 18:31:39 INFO - 'NO_EM_RESTART': '1', 18:31:39 INFO - 'PAGER': '/bin/cat', 18:31:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:39 INFO - 'PWD': '/builds/slave/test', 18:31:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:39 INFO - 'SHELL': '/bin/bash', 18:31:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p621HLrCY6/Listeners', 18:31:39 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 18:31:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:39 INFO - 'USER': 'cltbld', 18:31:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:39 INFO - 'XPC_FLAGS': '0x0', 18:31:39 INFO - 'XPC_SERVICE_NAME': '0', 18:31:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:39 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 18:31:39 INFO - Cleaning up... 18:31:39 INFO - Return code: 0 18:31:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f9a59d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d084d30>, '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 0x10cea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07bb20>, '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.DxQsqdX3jz/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.p621HLrCY6/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 18:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:31:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DxQsqdX3jz/Render', 18:31:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:39 INFO - 'HOME': '/Users/cltbld', 18:31:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:39 INFO - 'LOGNAME': 'cltbld', 18:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:39 INFO - 'MOZ_NO_REMOTE': '1', 18:31:39 INFO - 'NO_EM_RESTART': '1', 18:31:39 INFO - 'PAGER': '/bin/cat', 18:31:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:39 INFO - 'PWD': '/builds/slave/test', 18:31:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:39 INFO - 'SHELL': '/bin/bash', 18:31:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p621HLrCY6/Listeners', 18:31:39 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 18:31:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:39 INFO - 'USER': 'cltbld', 18:31:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:39 INFO - 'XPC_FLAGS': '0x0', 18:31:39 INFO - 'XPC_SERVICE_NAME': '0', 18:31:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:39 INFO - Downloading/unpacking psutil>=0.7.1 18:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:42 INFO - Installing collected packages: psutil 18:31:42 INFO - Running setup.py install for psutil 18:31:42 INFO - building 'psutil._psutil_osx' extension 18:31:42 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 18:31:43 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 18:31:43 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 18:31:43 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 18:31:43 INFO - building 'psutil._psutil_posix' extension 18:31:43 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 18:31:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:31:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:31:43 INFO - ^ 18:31:43 INFO - 1 warning generated. 18:31:43 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 18:31:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:43 INFO - Successfully installed psutil 18:31:43 INFO - Cleaning up... 18:31:43 INFO - Return code: 0 18:31:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:43 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 0x10d1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f9a59d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d084d30>, '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 0x10cea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07bb20>, '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.DxQsqdX3jz/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.p621HLrCY6/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 18:31:43 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 18:31:43 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 18:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DxQsqdX3jz/Render', 18:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:43 INFO - 'HOME': '/Users/cltbld', 18:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:43 INFO - 'LOGNAME': 'cltbld', 18:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:43 INFO - 'MOZ_NO_REMOTE': '1', 18:31:43 INFO - 'NO_EM_RESTART': '1', 18:31:43 INFO - 'PAGER': '/bin/cat', 18:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:43 INFO - 'PWD': '/builds/slave/test', 18:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:43 INFO - 'SHELL': '/bin/bash', 18:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p621HLrCY6/Listeners', 18:31:43 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 18:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:43 INFO - 'USER': 'cltbld', 18:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:43 INFO - 'XPC_FLAGS': '0x0', 18:31:43 INFO - 'XPC_SERVICE_NAME': '0', 18:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:31:44 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 18:31:44 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 18:31:44 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 18:31:44 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 18:31:44 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 18:31:44 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 18:31:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:31:46 INFO - Installing collected packages: mozsystemmonitor 18:31:46 INFO - Running setup.py install for mozsystemmonitor 18:31:46 INFO - Successfully installed mozsystemmonitor 18:31:46 INFO - Cleaning up... 18:31:47 INFO - Return code: 0 18:31:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:47 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 0x10d1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f9a59d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d084d30>, '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 0x10cea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07bb20>, '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.DxQsqdX3jz/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.p621HLrCY6/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 18:31:47 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 18:31:47 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 18:31:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DxQsqdX3jz/Render', 18:31:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:47 INFO - 'HOME': '/Users/cltbld', 18:31:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:47 INFO - 'LOGNAME': 'cltbld', 18:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:47 INFO - 'MOZ_NO_REMOTE': '1', 18:31:47 INFO - 'NO_EM_RESTART': '1', 18:31:47 INFO - 'PAGER': '/bin/cat', 18:31:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:47 INFO - 'PWD': '/builds/slave/test', 18:31:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:47 INFO - 'SHELL': '/bin/bash', 18:31:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p621HLrCY6/Listeners', 18:31:47 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 18:31:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:47 INFO - 'USER': 'cltbld', 18:31:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:47 INFO - 'XPC_FLAGS': '0x0', 18:31:47 INFO - 'XPC_SERVICE_NAME': '0', 18:31:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:47 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 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 18:31:49 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:50 INFO - Downloading docopt-0.6.1.tar.gz 18:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:50 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:50 INFO - Running setup.py install for blobuploader 18:31:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:51 INFO - Running setup.py install for requests 18:31:51 INFO - Running setup.py install for docopt 18:31:51 INFO - Successfully installed blobuploader requests docopt 18:31:51 INFO - Cleaning up... 18:31:51 INFO - Return code: 0 18:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:51 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 0x10d1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f9a59d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d084d30>, '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 0x10cea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07bb20>, '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.DxQsqdX3jz/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.p621HLrCY6/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 18:31:51 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 18:31:51 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 18:31:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DxQsqdX3jz/Render', 18:31:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:51 INFO - 'HOME': '/Users/cltbld', 18:31:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:51 INFO - 'LOGNAME': 'cltbld', 18:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:51 INFO - 'MOZ_NO_REMOTE': '1', 18:31:51 INFO - 'NO_EM_RESTART': '1', 18:31:51 INFO - 'PAGER': '/bin/cat', 18:31:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:51 INFO - 'PWD': '/builds/slave/test', 18:31:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:51 INFO - 'SHELL': '/bin/bash', 18:31:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p621HLrCY6/Listeners', 18:31:51 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 18:31:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:51 INFO - 'USER': 'cltbld', 18:31:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:51 INFO - 'XPC_FLAGS': '0x0', 18:31:51 INFO - 'XPC_SERVICE_NAME': '0', 18:31:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:52 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-5_QLaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:52 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-1YGvgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:52 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-04ZB6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:52 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-ZVLIQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:52 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-VVcPXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:52 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-MkfHwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:52 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-fJW9iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:52 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-dwEcYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:52 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-NMWUf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:52 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-AOX7xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:53 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-o8lQvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:53 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-FxkORX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:53 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-MhvuA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:53 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-9M_JtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:53 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-Rodf2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:53 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-Hd6jWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:53 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-Cms1Kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:53 INFO - Running setup.py install for manifestparser 18:31:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:53 INFO - Running setup.py install for mozcrash 18:31:54 INFO - Running setup.py install for mozdebug 18:31:54 INFO - Running setup.py install for mozdevice 18:31:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Running setup.py install for mozfile 18:31:54 INFO - Running setup.py install for mozhttpd 18:31:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Running setup.py install for mozinfo 18:31:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Running setup.py install for mozInstall 18:31:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:54 INFO - Running setup.py install for mozleak 18:31:55 INFO - Running setup.py install for mozlog 18:31:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:55 INFO - Running setup.py install for moznetwork 18:31:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:55 INFO - Running setup.py install for mozprocess 18:31:55 INFO - Running setup.py install for mozprofile 18:31:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:55 INFO - Running setup.py install for mozrunner 18:31:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:55 INFO - Running setup.py install for mozscreenshot 18:31:56 INFO - Running setup.py install for moztest 18:31:56 INFO - Running setup.py install for mozversion 18:31:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:56 INFO - Cleaning up... 18:31:56 INFO - Return code: 0 18:31:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:56 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')]} 18:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:56 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')]} 18:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:56 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 0x10d1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f9a59d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d084d30>, '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 0x10cea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07bb20>, '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.DxQsqdX3jz/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.p621HLrCY6/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 18:31:56 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 18:31:56 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 18:31:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DxQsqdX3jz/Render', 18:31:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:31:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:31:56 INFO - 'HOME': '/Users/cltbld', 18:31:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:31:56 INFO - 'LOGNAME': 'cltbld', 18:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:56 INFO - 'MOZ_NO_REMOTE': '1', 18:31:56 INFO - 'NO_EM_RESTART': '1', 18:31:56 INFO - 'PAGER': '/bin/cat', 18:31:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:56 INFO - 'PWD': '/builds/slave/test', 18:31:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:31:56 INFO - 'SHELL': '/bin/bash', 18:31:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p621HLrCY6/Listeners', 18:31:56 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 18:31:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:31:56 INFO - 'USER': 'cltbld', 18:31:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:31:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:56 INFO - 'XPC_FLAGS': '0x0', 18:31:56 INFO - 'XPC_SERVICE_NAME': '0', 18:31:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:56 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-FxHZoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:56 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-t1IlOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:56 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-KQ_AJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:56 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)) 18:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:56 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-TLtbTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:57 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)) 18:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:57 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-bLcCHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:57 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)) 18:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:57 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-hjtT3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:57 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)) 18:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:57 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-D3mxBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:57 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)) 18:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:57 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-PIHCTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:57 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)) 18:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:57 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-MS6iCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:57 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)) 18:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:57 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-qObqFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:57 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)) 18:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:57 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-3ZkgoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:57 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)) 18:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:57 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-440mHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:57 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)) 18:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:57 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-BIIqD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:58 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)) 18:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:58 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-GLzzDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:58 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)) 18:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:58 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-nS2uVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:58 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)) 18:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:58 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-QUlkSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:58 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)) 18:31:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:58 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-IIiOIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:58 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)) 18:31:58 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:58 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:58 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)) 18:31:58 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)) 18:31:58 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)) 18:31:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:00 INFO - Downloading blessings-1.6.tar.gz 18:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:32:00 INFO - Installing collected packages: blessings 18:32:00 INFO - Running setup.py install for blessings 18:32:00 INFO - Successfully installed blessings 18:32:00 INFO - Cleaning up... 18:32:01 INFO - Return code: 0 18:32:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:32:01 INFO - Reading from file tmpfile_stdout 18:32:01 INFO - Current package versions: 18:32:01 INFO - blessings == 1.6 18:32:01 INFO - blobuploader == 1.2.4 18:32:01 INFO - docopt == 0.6.1 18:32:01 INFO - manifestparser == 1.1 18:32:01 INFO - mozInstall == 1.12 18:32:01 INFO - mozcrash == 0.16 18:32:01 INFO - mozdebug == 0.1 18:32:01 INFO - mozdevice == 0.48 18:32:01 INFO - mozfile == 1.2 18:32:01 INFO - mozhttpd == 0.7 18:32:01 INFO - mozinfo == 0.9 18:32:01 INFO - mozleak == 0.1 18:32:01 INFO - mozlog == 3.1 18:32:01 INFO - moznetwork == 0.27 18:32:01 INFO - mozprocess == 0.22 18:32:01 INFO - mozprofile == 0.28 18:32:01 INFO - mozrunner == 6.11 18:32:01 INFO - mozscreenshot == 0.1 18:32:01 INFO - mozsystemmonitor == 0.0 18:32:01 INFO - moztest == 0.7 18:32:01 INFO - mozversion == 1.4 18:32:01 INFO - psutil == 3.1.1 18:32:01 INFO - requests == 1.2.3 18:32:01 INFO - wsgiref == 0.1.2 18:32:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:01 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 0x10d1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f9a59d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d084d30>, '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 0x10cea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07bb20>, '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.DxQsqdX3jz/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.p621HLrCY6/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 18:32:01 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 18:32:01 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 18:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DxQsqdX3jz/Render', 18:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:01 INFO - 'HOME': '/Users/cltbld', 18:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:01 INFO - 'LOGNAME': 'cltbld', 18:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:01 INFO - 'MOZ_NO_REMOTE': '1', 18:32:01 INFO - 'NO_EM_RESTART': '1', 18:32:01 INFO - 'PAGER': '/bin/cat', 18:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:01 INFO - 'PWD': '/builds/slave/test', 18:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:01 INFO - 'SHELL': '/bin/bash', 18:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p621HLrCY6/Listeners', 18:32:01 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 18:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:01 INFO - 'USER': 'cltbld', 18:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:01 INFO - 'XPC_FLAGS': '0x0', 18:32:01 INFO - 'XPC_SERVICE_NAME': '0', 18:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:01 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)) 18:32:01 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)) 18:32:01 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)) 18:32:01 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)) 18:32:01 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)) 18:32:01 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)) 18:32:01 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)) 18:32:01 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)) 18:32:01 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)) 18:32:01 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)) 18:32:01 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)) 18:32:01 INFO - Cleaning up... 18:32:01 INFO - Return code: 0 18:32:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f9a59d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d084d30>, '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 0x10cea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07bb20>, '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.DxQsqdX3jz/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.p621HLrCY6/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 18:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DxQsqdX3jz/Render', 18:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:01 INFO - 'HOME': '/Users/cltbld', 18:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:01 INFO - 'LOGNAME': 'cltbld', 18:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:01 INFO - 'MOZ_NO_REMOTE': '1', 18:32:01 INFO - 'NO_EM_RESTART': '1', 18:32:01 INFO - 'PAGER': '/bin/cat', 18:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:01 INFO - 'PWD': '/builds/slave/test', 18:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:01 INFO - 'SHELL': '/bin/bash', 18:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p621HLrCY6/Listeners', 18:32:01 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 18:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:01 INFO - 'USER': 'cltbld', 18:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:01 INFO - 'XPC_FLAGS': '0x0', 18:32:01 INFO - 'XPC_SERVICE_NAME': '0', 18:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:01 INFO - Downloading/unpacking jsonschema 18:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:32:04 INFO - Downloading/unpacking functools32 (from jsonschema) 18:32:04 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 18:32:04 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 18:32:04 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 18:32:04 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 18:32:04 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 18:32:04 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 18:32:04 INFO - Downloading functools32-3.2.3-2.tar.gz 18:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:32:04 INFO - warning: no files found matching '*.txt' 18:32:04 INFO - no previously-included directories found matching 'build' 18:32:04 INFO - no previously-included directories found matching 'dist' 18:32:04 INFO - no previously-included directories found matching '.git*' 18:32:04 INFO - Installing collected packages: jsonschema, functools32 18:32:04 INFO - Running setup.py install for functools32 18:32:04 INFO - warning: no files found matching '*.txt' 18:32:04 INFO - no previously-included directories found matching 'build' 18:32:04 INFO - no previously-included directories found matching 'dist' 18:32:04 INFO - no previously-included directories found matching '.git*' 18:32:04 INFO - Successfully installed jsonschema functools32 18:32:04 INFO - Cleaning up... 18:32:04 INFO - Return code: 0 18:32:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:32: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')]} 18:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32: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')]} 18:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:04 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 0x10d1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f9a59d4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d084d30>, '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 0x10cea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07bb20>, '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.DxQsqdX3jz/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.p621HLrCY6/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 18:32:04 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 18:32:04 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 18:32:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DxQsqdX3jz/Render', 18:32:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:04 INFO - 'HOME': '/Users/cltbld', 18:32:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:04 INFO - 'LOGNAME': 'cltbld', 18:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:04 INFO - 'MOZ_NO_REMOTE': '1', 18:32:04 INFO - 'NO_EM_RESTART': '1', 18:32:04 INFO - 'PAGER': '/bin/cat', 18:32:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:04 INFO - 'PWD': '/builds/slave/test', 18:32:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:04 INFO - 'SHELL': '/bin/bash', 18:32:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p621HLrCY6/Listeners', 18:32:04 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 18:32:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:04 INFO - 'USER': 'cltbld', 18:32:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:04 INFO - 'XPC_FLAGS': '0x0', 18:32:04 INFO - 'XPC_SERVICE_NAME': '0', 18:32:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:05 INFO - Downloading/unpacking flake8 18:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:32:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:32:07 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 18:32:07 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 18:32:07 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 18:32:07 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 18:32:07 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 18:32:07 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 18:32:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:32:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:32:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:32:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:32:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:32:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:32:08 INFO - no previously-included directories found matching 'docs/_build' 18:32:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:32:09 INFO - Running setup.py install for pep8 18:32:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:32:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:32:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:32:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:32:09 INFO - no previously-included directories found matching 'docs/_build' 18:32:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:32:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:32:09 INFO - Cleaning up... 18:32:09 INFO - Return code: 0 18:32:09 INFO - Running post-action listener: _resource_record_post_action 18:32:09 INFO - Running post-action listener: _start_resource_monitoring 18:32:09 INFO - Starting resource monitoring. 18:32:09 INFO - ##### 18:32:09 INFO - ##### Running install step. 18:32:09 INFO - ##### 18:32:09 INFO - Running pre-action listener: _resource_record_pre_action 18:32:09 INFO - Running main action method: install 18:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:32:09 INFO - Reading from file tmpfile_stdout 18:32:09 INFO - Detecting whether we're running mozinstall >=1.0... 18:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:32:09 INFO - Reading from file tmpfile_stdout 18:32:09 INFO - Output received: 18:32:09 INFO - Usage: mozinstall [options] installer 18:32:09 INFO - Options: 18:32:09 INFO - -h, --help show this help message and exit 18:32:09 INFO - -d DEST, --destination=DEST 18:32:09 INFO - Directory to install application into. [default: 18:32:09 INFO - "/builds/slave/test"] 18:32:09 INFO - --app=APP Application being installed. [default: firefox] 18:32:09 INFO - mkdir: /builds/slave/test/build/application 18:32:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:32:43 INFO - Reading from file tmpfile_stdout 18:32:43 INFO - Output received: 18:32:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:32:43 INFO - Running post-action listener: _resource_record_post_action 18:32:43 INFO - ##### 18:32:43 INFO - ##### Running run-tests step. 18:32:43 INFO - ##### 18:32:43 INFO - Running pre-action listener: _resource_record_pre_action 18:32:43 INFO - Running main action method: run_tests 18:32:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:43 INFO - 2016-03-04 18:32:43.642 screenresolution[1644:7562] starting screenresolution argv=screenresolution get 18:32:43 INFO - 2016-03-04 18:32:43.644 screenresolution[1644:7562] Display 0: 1600x1200x32@60 18:32:43 INFO - 2016-03-04 18:32:43.649 screenresolution[1645:7564] starting screenresolution argv=screenresolution list 18:32:43 INFO - Available Modes on Display 0 18:32:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:43 INFO - Intel Iris: 18:32:43 INFO - Chipset Model: Intel Iris 18:32:43 INFO - Type: GPU 18:32:43 INFO - Bus: Built-In 18:32:43 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:43 INFO - Vendor: Intel (0x8086) 18:32:43 INFO - Device ID: 0x0a2e 18:32:43 INFO - Revision ID: 0x0009 18:32:43 INFO - Displays: 18:32:43 INFO - Display: 18:32:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:43 INFO - Display Serial Number: 1600x1200 60 18:32:43 INFO - Main Display: Yes 18:32:43 INFO - Mirror: Off 18:32:43 INFO - Online: Yes 18:32:43 INFO - Rotation: Supported 18:32:43 INFO - Return code: 0 18:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:43 INFO - Python 2.7.3 18:32:43 INFO - Return code: 0 18:32:43 INFO - grabbing minidump binary from tooltool 18:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:43 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 0x10d084d30>, '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 0x10cea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:43 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 18:32:43 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 18:32:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:43 INFO - Return code: 0 18:32:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:32:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:32:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:32:45 INFO - Return code: 0 18:32:45 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/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.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 18:32:45 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/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.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 18:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DxQsqdX3jz/Render', 18:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:32:45 INFO - 'HOME': '/Users/cltbld', 18:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:32:45 INFO - 'LOGNAME': 'cltbld', 18:32:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:45 INFO - 'MOZ_NO_REMOTE': '1', 18:32:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:45 INFO - 'NO_EM_RESTART': '1', 18:32:45 INFO - 'PAGER': '/bin/cat', 18:32:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:45 INFO - 'PWD': '/builds/slave/test', 18:32:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:32:45 INFO - 'SHELL': '/bin/bash', 18:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p621HLrCY6/Listeners', 18:32:45 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 18:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:32:45 INFO - 'USER': 'cltbld', 18:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:45 INFO - 'XPC_FLAGS': '0x0', 18:32:45 INFO - 'XPC_SERVICE_NAME': '0', 18:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:32:45 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/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.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 18:32:45 INFO - mozversion application_buildid: 20160304155027 18:32:45 INFO - mozversion application_changeset: 69d357fb6a0b38239b855a9aeea863d035f9fca5 18:32:45 INFO - mozversion application_display_name: Nightly 18:32:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:45 INFO - mozversion application_name: Firefox 18:32:45 INFO - mozversion application_remotingname: firefox 18:32:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:32:45 INFO - mozversion application_vendor: Mozilla 18:32:45 INFO - mozversion application_version: 47.0a1 18:32:45 INFO - mozversion platform_buildid: 20160304155027 18:32:45 INFO - mozversion platform_changeset: 69d357fb6a0b38239b855a9aeea863d035f9fca5 18:32:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:32:45 INFO - mozversion platform_version: 47.0a1 18:32:45 INFO - using testdate: 1457145165 18:32:45 INFO - actual date: 1457145165 18:32:45 INFO - starting webserver on 'localhost:49272' 18:32:45 INFO - SUITE-START | Running 2 tests 18:32:45 INFO - TEST-START | dromaeo_css 18:32:45 INFO - operating with platform_type : mac_ 18:32:45 INFO - Initialising browser for dromaeo_css test... 18:32:45 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmpLovFL4/profile http://localhost:49272/getInfo.html) 18:32:48 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 18:32:48 INFO - PROCESS | 1663 | colorDepth:24 18:32:48 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 18:32:48 INFO - PROCESS | 1663 | __metrics 18:32:48 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:32:48 INFO - TEST-INFO | 1663: exit 0 18:32:48 INFO - Browser initialized. 18:32:48 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:48 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmpLovFL4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:33:01 INFO - PROCESS | 1667 | RSS: Main: 256212992 18:33:01 INFO - PROCESS | 1667 | 18:33:50 INFO - PROCESS | 1667 | 1457145230643 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] 18:36:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 18:36:03 INFO - PROCESS | 1667 | RSS: Main: 269586432 18:36:03 INFO - PROCESS | 1667 | 18:39:05 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 18:39:06 INFO - PROCESS | 1667 | RSS: Main: 281849856 18:39:06 INFO - PROCESS | 1667 | 18:42:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 18:42:08 INFO - PROCESS | 1667 | RSS: Main: 283193344 18:42:08 INFO - PROCESS | 1667 | 18:45:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 18:45:10 INFO - PROCESS | 1667 | RSS: Main: 284860416 18:45:10 INFO - PROCESS | 1667 | 18:48:13 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 18:48:13 INFO - PROCESS | 1667 | RSS: Main: 286486528 18:48:13 INFO - PROCESS | 1667 | 18:51:16 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 18:51:16 INFO - PROCESS | 1667 | RSS: Main: 290029568 18:51:16 INFO - PROCESS | 1667 | 18:51:16 INFO - PROCESS | 1667 | __start_tp_report 18:51:16 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 18:51:16 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 18:51:16 INFO - PROCESS | 1667 | |i|pagename|runs| 18:51:16 INFO - PROCESS | 1667 | |0;dojo.html;2943.0729320264118;3480.095175254434;3533.3110043541506;3565.251297227582;3568.821558922053;4466.3523789050605;5639.295088113986;5789.681567513785;5792.391798861122;5816.534677225823;4604.447466304048;5831.416858314166;5851.444112809277;5888.764449422018;5892.322382925965;4787.8324258650955;5222.973885130569;5241.397239317489;5398.568114550846;5406.243125962368;3839.9824046627664;4537.863864084083;4999.850004499871;5297;5323.121684921984;3942.4283478895545;5197.610179236553;5215.295935048758;5276.5251127398715;5321.308229930123;4188.4555007849085;5218.243354713545;5239.21411788231;5245.396779370345;5305.018571564273;5173.663711858717;5178.766955487012;5224.555912747421;5246.31797866275;5260.947390526084;4202.831886724527;5640.153976903456;5696.287964004499;5710.65736055838;5732.398098199712;6182.629042257479;6240.344763799781;6252.531060170505;6290.402411770874;6301.87396252077;5749.511291540182;6154.5384096192965;6180.783672571483;6227.439530442282;6353.523485738542;5927.762889484372;5931.051031834886;5944.197533333031;5949.6430214187285;6006.78976235834;5369.167778994262;6367.395097465734;6370.299267080617;6370.426661600478;6381.074744162071;6075.179850720185;6117.949202904643;6167.814965551041;6205.410486003822;6213.099100630474;6138.878900475427;6185.917464443704;6190.1952746142715;6239.656818875005;6241.063840423973;6126.9387306127255;6184.628922264678;6236.688165591793;6244.531660125509;6247.437730604267;5076.314697515862;6153.84615384619;6175.197224360804;6276.529260305495;6286.9056964145575;4930.112579735682;4932.630052746058;4935.531124543163;4952.133376659142;4961.578265847371;4437.112577484516;4446.755428451402;4451.866444006685;4459;4464.107178564235;5546.334439867242;5750.6262092963825;5769.07694768835;5849.736761845727;5856.94143058564;6200.937990620127;6204.627722336584;6240.781572644935;6241.937580624226;6244;5539.362973258047;5798.565107616945;5807.535397168216;5820.097884827858;5824.446677565625;5304.283921670525;5396.168720208696;5447.5641948644015;5450.1007333789485;5500.917486237709;6438.313978323684;6467.773627923;6472.805815825533;6474.643894585843;6486.189226346707;4971.65198436106;6273.905891411724;6274.811755647338;6278.15244941927;6284.937150628618;6378.553501254868;6428.517861160338;6465.0948867157695;6494.772682956074;6501.122348482894;6176.135341052166;6249.0626406039455;6255.874882502233;6258.499320054476;6272.435480806749;6162.890679677701;6188.257409110935;6256.311805701278;6261.530385221035;6264.968675156595;5091.821786237464;5764.13537969308;5953.196318497121;6008.669523176267;6123.1606109212;6154.353792851686;6199.845003874939;6223.471004964629;6223.875522489616;6228.844278893064;5313.574914006947;5679.290088738908;5723.284589426322;6010.158577799024;6018.277806663228;5003.799848006039;6142.959235178615;6190.41191086846;6205;6218.5647004709235;5282.392524859691;6021.729022193924;6080.48315893154;6093.664848433379;6123.112148738319 18:51:16 INFO - PROCESS | 1667 | |1;ext.html;403.27611936573845;487.23990574703464;547.7699366266168;600.3006497430493;644.0339490763854;38146.42780358297;38675.03312417184;38710.8064459678;38737.612623873756;38794.80602596987;41897.16205675892;42371;42428.15143697124;42511.9372015699;42567;8213.726872334797;9569;9641.855372169388;9677.129058384744;9732.56203470842;9571.138597526222;9695.127438530531;9723.27075469339;9725.51372431379;9726.70819875405;9648.517574121266;9700.272479564026;9739.464329461876;9753.756156096084;9776.071273229067;9630;9691.418514889128;9727.221822254203;9762.560684769202;9770.316077874551;9510.572024258925;9634.566444510014;9652.179564737005;9673.322867399285;9687.903120968771;39309.60690393117;39623.603763962565;39784;39859;39883.40174897379;3181.2046988252937;3301.4552598821165;3429.477747796723;3476.3047390521997;3814.8855534334016;23092.42268943273;29155.41689166226;29621.555676664866;29995.40009199804;30494;2697.8381297122237;2737.301987993069;2752.678714217187;2801.089645865102;2892.47935371633;461351;461717;465683.6715816433;466143;466501.9999999966;45201.38388928878;65110.674446628414;65178.34821651818;65585.67207163933;65793.34206657967;46157.7692111544;46272.30591541129;46289.53710462852;46549;46561.603151905496;15701.214939253221;15807.446739364066;15853.207339632972;15871.12708801004;15906.204689765465;10720.303180293256;12320.383980801103;12700.110992230455;12750.426230819636;12756.80864787029;14923.70152596942;14942.551723448314;15293;15358.310585835548;15375.308111135026;5425.059559782032;6636.402723754885;6705.329467053353;6711.563748356439;6727.058211850345;1009.4498498318287;1015.0002247785925;1057.281048886749;1138.1293310617384;1157.9636225578229;29747.620190384718;29948.85025574858;30273;30356.696433035828;30393.69606303953;1070.3203465799274;1118.3960661243;1162.8255761635653;1194.199886076331;1232.4471166330488;11957.282563046245;14478.565643030726;14484.85515144835;14761.40954361835;14933.70132597342;341999;435142;437191;437801;440071;58969.41030589725;60938;61325.693371532856;61358.77282454326;61376.693116535025;1440.481426686392;1482.770170623555;1489.6871656951944;1500.6998600279987;1504.6840163565555;22511.64930104199;29443.411131777673;29545.704542955154;29837.403251935273;30274.394512110073;53758.73120634372;53827.730861345444;53929;54093.91812163813;54307.72846135744;453962.730186347;479816;479861;483661;484358.1564184313;27463.588046179724;33781.83109084439;33962.320753584296;34133.82933085319;34528.48207276943;36252.81873590615;45585.544144559455;46290.76854615705;46825;47585;37009;38170.85487435381;38342;38920.80539597284;38999.6100038996;35018.949431517096;37527.87416377513;37648.623513765604;38014;38470;36978.815105924295;37237.88286351414;37462.8126859364;38000.429993549566;38313;26053.609195862457;32903.83548082244;32981.50527742134;33368.33263334671;33692.83153584216;24944.12695555647;24988.75011249864;25043.419409097543;25305.74694253034;25565.3608659785 18:51:16 INFO - PROCESS | 1667 | |2;jquery.html;355.948387483815;365.73118757713087;367.94480827875833;369.7467234944065;371.74535443221384;19399;19785.307514237003;20887.895560522215;21043.579128417423;21064.789352106476;20605.690914636292;20633.690494642593;20932.267370642032;21083.262085827;21179.94100294987;5692.857678558028;5916.733746981375;5949.970250148744;5957.255343082114;5961.284645842505;5480.862978425552;5764.106563482667;5767.990601644696;5770.624909380897;5807.82576522705;5642.351129620105;5733.655980641154;5752.137179423078;5766.250387449647;5964.314103878066;5909.084091965752;5909.497692696126;5930.762769489237;5959.642421454727;5971.552133589998;5607.299087614048;5669.773209071632;5682.715864206773;5687.459691329317;5687.914681279743;13084.21494710311;13293.800592991112;13393.531226407127;13470.124441911343;13559;1978.429827099405;1996.5308152584132;2114.450242936832;2277.6355783074796;2721.877515511807;9632.229421646252;9707.417554946725;9976.750581235527;10076.949615251877;10241.948790256076;1697.719876220422;1721.208244207666;1727.265911987413;1733.5319463744845;1780.3857669104138;102267;105945.47027264969;106486.33784155457;106678;106780.46609766902;11263.718407039889;11430.856914308502;11506.539738410538;11514.251573647685;11672.416379181008;13883.236421996888;13930.512432064828;13935.233562154179;13937.58187254384;13943;7747.806304842311;7976.760697179094;8649.567521623894;8652.264557512555;8730.781730456662;8747;8761.474311541328;8775;8824.205821476098;8862.158094980967;4436.46762388509;4548.204064288736;4564;4576.633869290449;4604.700694454849;1580.2730743857953;1617.951461456158;1925.8266755991747;1950.8439324853978;1953.1210955070276;941.5433514745343;949.2548349545574;954.8376775948105;1018.3991445047458;1028.5422986770816;19368.322108726126;19387.806121938884;19844;20194.59610807805;20421.285255016002;876.8903887014123;888.2094935507274;909.4088842252456;976.5068640336584;1040.557762950743;9490.446177722535;10536.631217907336;10726.302790318605;10828.566857325619;10866.348019118877;491030.6345404822;509046;536994;623069;640613;58089.128663070085;88591;94337;117804;123651.38174309251;973.9659111931048;994.8457989011715;1011.2163073618005;1011.2415688233824;1013.5844303835393;17725.734113988558;17908.373206937693;18146.546336341697;18191.45425637233;18215.45353639393;32625.836870816445;38762;48026.27960580664;52309.95380092453;52629.473705262455;68238;72139;73285.6335718318;74140.62929685533;76418.8537171954;6602.537822352389;6768.9661551691925;7823.178566250689;7854.803629909069;8021.398395120506;10863.891361086287;13261.204327740366;13330.266835323762;13732;13818.723625527635;10116.797664046531;11193.104551636012;11295.096392288762;11434.656960291204;11475.483603237708;11230.7753844921;11242.213045086766;11481.425928703698;11547.364894930524;11580.552430946133;11603.535858565563;11771.764564708828;11900.107491937966;11985.820212696992;12075.335856527623;6551.344865513411;7904.6838126474295;7934.801629959297;8054.395920305883;8213.466124701876;8396.076431592397;10623.734406639587;11631.76736465283;11903.047756179658;11949.342786146846 18:51:16 INFO - PROCESS | 1667 | |3;mootools.html;1631.1273468694246;1645.8518733314004;1947.8539109566777;2025.1696804310227;2027.2195204846148;7998.560079195642;8608.225259726623;8791.956040219799;8958.910410895889;8983.281337493001;8788.692395766133;8795.252403545706;8877.55612219388;8884.822303553925;8913.554322283891;2458.9262322130367;2468.469279104992;2489.3403248139257;2492.9252122436264;2498.8250822442437;2435.8782060896974;2491.302435318114;2501.9874900625564;2504.486580251044;2506.385935445809;2407.590709579367;2458.373114855718;2487.962680559793;2503.086373473678;2509.6110102934076;1931.3240365871973;2454.7054353477606;2465.6055031195015;2477.170148000422;2511.259178542334;2052.404802607242;2162.902669379882;2445.058652418814;2516.6350879122606;2520.3069155982066;8969.103089691043;8996.955015224947;9000.189982901506;9044.457332560001;9053.59258833354;5261.342332208474;5444.863878403072;5571.13647384656;5627.943720562783;5642.943570564283;3502.8423720932365;3573.4103872860946;3706.9073273168115;3717.739758216926;3717.962820371789;902.9954850225772;991.5092029445399;1051.2483574244375;1086.8369744538304;1090.7763908398758;9591.760205994837;10624.671916010499;11668.591599294068;12274.263544187288;12325.815112773316;4909.459959404463;4939.185034469272;4955.207166853286;4974.1543937530705;4979.427365852901;10331;10413.739656508647;10436.843447348145;10468.842967355497;10474.790504189874;4619.722816631013;5529.778808847601;5549.833504994856;5595.132754423071;5595.132754423071;4445.310976798537;4886.193778026586;4996.4254110777;5024.748762561857;5055.595552355876;3961.6830653547645;4048.3927410888014;4061.817218225187;4083.1425400666194;4090.202410529918;1315.6316231455207;1336.385262779113;1340.7921772125337;1348.797680347936;1350.864913508661;1184.324934787163;1369;1406.1282005156663;1419.531554586984;1432.2194404049817;8200.630971606291;8286;8383.790405239795;8486.32109431244;8540;512.3314075131914;515.2554558662696;519.6855902179203;520.3339725151811;522.9921551176735;6296.118543403927;6355.586886852339;6380.202474690664;6381.744730210739;6420.454261387741;10574.735631609117;10946.890531094747;10992.615258466076;11025.889741102486;11038.668839934815;8831.514266715263;10612.681619551426;10809.729756755987;10858.891411085788;10937;8425.662973480992;8548.871766923501;8550.315974722133;8559.186877246651;8608.010078841013;6278.4035516625845;7996.680132794623;8060.637271322922;8151.144129866516;8185;9532.189763870148;9632.518374081128;9734.707958761248;9739.366941148803;9840.458774767456;9872.654457093968;10015.39907605546;10141.949290253502;10154.644587439405;10232.744181395525;6739.5619284746335;7464.328210461084;7523.811904702207;7716.691332346868;7765.495242809199;8254.637984732692;8295.875561866456;8321.583920804056;8352.33181345503;8394.412391132562;6403.135576697086;7394.2975417335265;7481.064866891638;7577.924220757943;7629.504082234859;6387.265464471645;7321;7649.808754780953;7738.419618528746;7744.535327880345;7618.276263754934;7891.68433262686;7942.761717148494;7945.24520170606;7945.523268603903;7071.611061391673;7119.8932016020835;7171.103612048494;7190.604516751629;7209.026781384446;7222.09723784527;7300.12398512182;7303.415726741954;7313.23211062852;7341.082364704412 18:51:16 INFO - PROCESS | 1667 | |4;prototype.html;304.19692013085455;332.5593588495244;334.807485695725;338.1343759974464;338.63089232736314;6908.654567271635;6957.269486703893;6964.303569643033;6981.790546283607;7021.22766495685;5449.373322067963;6900.861982760342;6906.723731050764;6937.479689023318;6946.513744037907;3991.6407523322896;4754.334393184957;5016.122178618745;5039.294498770175;5081.46644602317;4536.818527258923;4596.747178905159;5054.9241761373605;5063.8480845574695;5065.848024559269;4986.975065124688;4995.6003519718515;5002.599792016648;5021.949780502185;5025.572826309768;4440.533743956887;4613.861584152481;5006;5008.599312055063;5022.121128802463;4317.352397140423;4327.913441731148;4336;4339.457567804025;4350.282203436429;6344.619322840645;6639.502037347218;6664.400203981617;6664.866702665968;6673.332666733337;5840.591158618899;5847.26909136358;5864.970675146639;5880.97059514704;5901.911471327933;7429.368503677194;7436;7446.340781006474;7450.105987281561;7486.9251307486775;4728.598069164125;4729.6452766042685;4732.503087175865;4734.928976065362;4738.265568836836;6109.511239100906;7750.14748377678;7802;7836.138024817265;7903;4106.726914656466;4585.79363928624;4659.114768194032;4659.767011649404;4766.380370551876;4807.6153907688;4819.807207711722;4822.348982887335;4833.299171620095;4861.222204447342;5827.1841942127285;5834.416558344132;5854;5854.912176317359;5866.560007999417;7357.448191385667;7405.444591655647;7434.925650743423;7438.73964411243;7451.664675089634;1590.6898154859691;1644.9342026319052;1655.0731590309465;1677.0692265792359;1684.1242553871919;908.9500077495801;949.4445749236636;1061.490484567412;1063.1176123817213;1066.989330106689;6789;6799.932000680029;6823.1812182538415;6824.385805277549;6851.45188384928;7642.923570764221;7674.654640541189;7675.846483070307;7692.807679807937;7694.499857509244;5354.089804733127;5885.76398956224;6526.086347911296;6734.8653026940165;6800.183977922681;3728.6271372862498;4031.798410079543;4059.6143366380147;4062.3297155968935;4079.4084857695466;5694.914576281359;7875.488093273919;8111.634976426075;8146.940897683382;8162.551059691656;6443.387878151568;8063;8082.19178082187;8099.554524501209;8119.106898241189;8131.878021829677;8146.389020823462;8154.143814899468;8168.673253069811;8169.959150204211;7558.13081495635;7789.610519474117;7840.803979900548;7857.135715071223;7861.567613781068;7576.3938884887975;7628.8938103973505;7645.273698998586;7663.655135519027;7669.233076692286;8117.228863257981;8145.51126932386;8154.306883914696;8161.510309381219;8163.632636531252;4805.687630304019;4812.590929771009;4823.831165909176;4827.155247831545;4848.781804818721;7398.630068496446;7769.223077692185;7784.260495252942;7806.336461400844;7847.058352997677;7456.888146677913;7462.067241594801;7481.887771683538;7491.3632341251605;7522.435817313833;6000.279966404059;7451.627418629156;7470.6264686766535;7481.812954676177;7482.887756683763;6740.157480314961;7219.45854060937;7257.346838784535;7261.38278246355;7277.2722727726805;6404.9039264412;7436.665350059152;7486.850262994819;7508;7512.849743005;7259.963700181465;7265.818354540967;7274.672639731119;7284.053073100463;7293.234210407831 18:51:16 INFO - PROCESS | 1667 | |5;yui.html;605.818254523643;635.9300476947535;665.980020599382;702.5924963521159;717.2268552781243;14464.638384040405;14682.779758303634;14707.92646036771;14751.48369807057;16550.337986480557;15572.610684732887;15655;15708.293126809293;15709.607259818482;15722.685546289067;935.8362286599852;947.275334369208;952.2286947572454;954.265215783846;954.3558098283665;758.2682711183706;932.5104320231865;946.9479178645172;948.5115165689675;956.6173530587786;720.4056653261055;965.9661911833088;976.7460460280307;981.1807141037242;988.9554970026367;923.9769005774842;972.6838777397375;974.7611835100375;982.5136557404095;983.4836710726854;647.6632151281354;729.2160927003439;733.3509843788232;737.9926200737978;738.2506755643027;15113.017653852574;15226.847731522765;15240.23798810055;15241.61895952599;15260.236988150547;12268.815967760402;12304.384780760925;12305.50777968889;12417.62747117588;12556.623301300975;8113.077453458949;9968.40189588627;10037.146842518394;10111.494425278706;10410.843837342445;3389.8305084745666;3392.6098498672723;3393.2195595013286;3398.1844357354303;3399.6090449598364;64129.67935160341;79659;81496.59251703763;83560.58219708923;83790;9006.144416280444;9106.089391060841;9126.908730912739;9183.494907780136;9274.860877086849;19936.800631993785;20101.39695809128;20523;20525.38423847287;20580.794192058187;7240.52936559122;7269.600171990592;7274.636268186569;7478.027856378745;7552.811179720551;4021.1957608477837;4078.7552746835286;4108.712390132662;4119.485064366954;4129.050318426779;3577.195131095483;3599.1002249437643;3613.457981302826;3626.492291079251;3638.6725194732603;556.7445410599073;658.1246941567704;666.74330382802;670.3698523388;670.8322919270182;465.5623713709103;515.943246242913;562.8817948230835;567.633876149881;593.4599514441837;8066.838663226703;8068.878966815502;8140.715074972348;8182.386321025947;8397.076321604618;490.49724032866595;525.3957948359341;553.9861503462446;559.7509108446784;581.1457157977766;3299.5050742388353;3701.333759923186;3806.276807406584;3838.0021194489077;3846.653801157909;89585.55207223922;89736.5513172443;90932.54533727422;90989.54505227432;96261;78459.60770196113;79220.415591689;79399.60300198462;79488.60255698685;80763.59618201871;51926.96146077057;55587.05161854768;59831.50421239504;67917.66041169861;70077;5585.3297604287745;7545.50954187976;7695.345895598937;7799.844003120019;7960.960195198987;37492.81253593715;41942.790286048374;43843.78078109589;49251.7537412325;49270.50729492803;52265.21602176046;62121.689391552754;65715;67240;67409;9716.611335546499;9777.853332200166;9808.803823923625;10041.397516149054;10111.59553617847;10583.364998100138;10609.9469502652;10679.839802403125;10718.73203169927;11070.28043177191;10080.092791648787;10144.54349554257;10227.488625568543;10349.016843399864;10562.735931601772;10094.697159085239;10153.796924061626;10207.387556746618;10279.588816447258;10376.740581485523;9891.901080989099;9958.44833942846;9997.000299969945;10035.046670566284;10296.948515257376;8643.783905402415;8697.521636310064;8797.912020879965;8834.734957951272;8933.687320943736;8653.091425400242;8692.565371731262;8755.343349248704;8885.555722213734;8899.110088991049 18:51:16 INFO - PROCESS | 1667 | __end_tp_report 18:51:16 INFO - PROCESS | 1667 | __start_cc_report 18:51:16 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,352 18:51:16 INFO - PROCESS | 1667 | __end_cc_report 18:51:16 INFO - PROCESS | 1667 | __startTimestamp1457146276371__endTimestamp 18:51:16 INFO - PROCESS | 1667 | 18:51:16 INFO - PROCESS | 1667 | ------- Summary: start ------- 18:51:16 INFO - PROCESS | 1667 | Number of tests: 6 18:51:16 INFO - PROCESS | 1667 | 18:51:16 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5691.82 Median:5931.05 stddev:717.29 (12.1%) stddev-sans-first:686.31 18:51:16 INFO - PROCESS | 1667 | Values: 2943.1 3480.1 3533.3 3565.3 3568.8 4466.4 5639.3 5789.7 5792.4 5816.5 4604.4 5831.4 5851.4 5888.8 5892.3 4787.8 5223.0 5241.4 5398.6 5406.2 3840.0 4537.9 4999.9 5297.0 5323.1 3942.4 5197.6 5215.3 5276.5 5321.3 4188.5 5218.2 5239.2 5245.4 5305.0 5173.7 5178.8 5224.6 5246.3 5260.9 4202.8 5640.2 5696.3 5710.7 5732.4 6182.6 6240.3 6252.5 6290.4 6301.9 5749.5 6154.5 6180.8 6227.4 6353.5 5927.8 5931.1 5944.2 5949.6 6006.8 5369.2 6367.4 6370.3 6370.4 6381.1 6075.2 6117.9 6167.8 6205.4 6213.1 6138.9 6185.9 6190.2 6239.7 6241.1 6126.9 6184.6 6236.7 6244.5 6247.4 5076.3 6153.8 6175.2 6276.5 6286.9 4930.1 4932.6 4935.5 4952.1 4961.6 4437.1 4446.8 4451.9 4459.0 4464.1 5546.3 5750.6 5769.1 5849.7 5856.9 6200.9 6204.6 6240.8 6241.9 6244.0 5539.4 5798.6 5807.5 5820.1 5824.4 5304.3 5396.2 5447.6 5450.1 5500.9 6438.3 6467.8 6472.8 6474.6 6486.2 4971.7 6273.9 6274.8 6278.2 6284.9 6378.6 6428.5 6465.1 6494.8 6501.1 6176.1 6249.1 6255.9 6258.5 6272.4 6162.9 6188.3 6256.3 6261.5 6265.0 5091.8 5764.1 5953.2 6008.7 6123.2 6154.4 6199.8 6223.5 6223.9 6228.8 5313.6 5679.3 5723.3 6010.2 6018.3 5003.8 6143.0 6190.4 6205.0 6218.6 5282.4 6021.7 6080.5 6093.7 6123.1 18:51:16 INFO - PROCESS | 1667 | 18:51:16 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:59973.80 Median:38572.52 stddev:120521.69 (312.5%) stddev-sans-first:120776.79 18:51:16 INFO - PROCESS | 1667 | Values: 403.3 487.2 547.8 600.3 644.0 38146.4 38675.0 38710.8 38737.6 38794.8 41897.2 42371.0 42428.2 42511.9 42567.0 8213.7 9569.0 9641.9 9677.1 9732.6 9571.1 9695.1 9723.3 9725.5 9726.7 9648.5 9700.3 9739.5 9753.8 9776.1 9630.0 9691.4 9727.2 9762.6 9770.3 9510.6 9634.6 9652.2 9673.3 9687.9 39309.6 39623.6 39784.0 39859.0 39883.4 3181.2 3301.5 3429.5 3476.3 3814.9 23092.4 29155.4 29621.6 29995.4 30494.0 2697.8 2737.3 2752.7 2801.1 2892.5 461351.0 461717.0 465683.7 466143.0 466502.0 45201.4 65110.7 65178.3 65585.7 65793.3 46157.8 46272.3 46289.5 46549.0 46561.6 15701.2 15807.4 15853.2 15871.1 15906.2 10720.3 12320.4 12700.1 12750.4 12756.8 14923.7 14942.6 15293.0 15358.3 15375.3 5425.1 6636.4 6705.3 6711.6 6727.1 1009.4 1015.0 1057.3 1138.1 1158.0 29747.6 29948.9 30273.0 30356.7 30393.7 1070.3 1118.4 1162.8 1194.2 1232.4 11957.3 14478.6 14484.9 14761.4 14933.7 341999.0 435142.0 437191.0 437801.0 440071.0 58969.4 60938.0 61325.7 61358.8 61376.7 1440.5 1482.8 1489.7 1500.7 1504.7 22511.6 29443.4 29545.7 29837.4 30274.4 53758.7 53827.7 53929.0 54093.9 54307.7 453962.7 479816.0 479861.0 483661.0 484358.2 27463.6 33781.8 33962.3 34133.8 34528.5 36252.8 45585.5 46290.8 46825.0 47585.0 37009.0 38170.9 38342.0 38920.8 38999.6 35018.9 37527.9 37648.6 38014.0 38470.0 36978.8 37237.9 37462.8 38000.4 38313.0 26053.6 32903.8 32981.5 33368.3 33692.8 24944.1 24988.8 25043.4 25305.7 25565.4 18:51:16 INFO - PROCESS | 1667 | 18:51:16 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:31986.95 Median:11728.79 stddev:93422.36 (796.5%) stddev-sans-first:93654.24 18:51:16 INFO - PROCESS | 1667 | Values: 355.9 365.7 367.9 369.7 371.7 19399.0 19785.3 20887.9 21043.6 21064.8 20605.7 20633.7 20932.3 21083.3 21179.9 5692.9 5916.7 5950.0 5957.3 5961.3 5480.9 5764.1 5768.0 5770.6 5807.8 5642.4 5733.7 5752.1 5766.3 5964.3 5909.1 5909.5 5930.8 5959.6 5971.6 5607.3 5669.8 5682.7 5687.5 5687.9 13084.2 13293.8 13393.5 13470.1 13559.0 1978.4 1996.5 2114.5 2277.6 2721.9 9632.2 9707.4 9976.8 10076.9 10241.9 1697.7 1721.2 1727.3 1733.5 1780.4 102267.0 105945.5 106486.3 106678.0 106780.5 11263.7 11430.9 11506.5 11514.3 11672.4 13883.2 13930.5 13935.2 13937.6 13943.0 7747.8 7976.8 8649.6 8652.3 8730.8 8747.0 8761.5 8775.0 8824.2 8862.2 4436.5 4548.2 4564.0 4576.6 4604.7 1580.3 1618.0 1925.8 1950.8 1953.1 941.5 949.3 954.8 1018.4 1028.5 19368.3 19387.8 19844.0 20194.6 20421.3 876.9 888.2 909.4 976.5 1040.6 9490.4 10536.6 10726.3 10828.6 10866.3 491030.6 509046.0 536994.0 623069.0 640613.0 58089.1 88591.0 94337.0 117804.0 123651.4 974.0 994.8 1011.2 1011.2 1013.6 17725.7 17908.4 18146.5 18191.5 18215.5 32625.8 38762.0 48026.3 52310.0 52629.5 68238.0 72139.0 73285.6 74140.6 76418.9 6602.5 6769.0 7823.2 7854.8 8021.4 10863.9 13261.2 13330.3 13732.0 13818.7 10116.8 11193.1 11295.1 11434.7 11475.5 11230.8 11242.2 11481.4 11547.4 11580.6 11603.5 11771.8 11900.1 11985.8 12075.3 6551.3 7904.7 7934.8 8054.4 8213.5 8396.1 10623.7 11631.8 11903.0 11949.3 18:51:16 INFO - PROCESS | 1667 | 18:51:16 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6105.29 Median:2892.17 stddev:3228.15 (111.6%) stddev-sans-first:3219.69 18:51:16 INFO - PROCESS | 1667 | Values: 1631.1 1645.9 1947.9 2025.2 2027.2 7998.6 8608.2 8792.0 8958.9 8983.3 8788.7 8795.3 8877.6 8884.8 8913.6 2458.9 2468.5 2489.3 2492.9 2498.8 2435.9 2491.3 2502.0 2504.5 2506.4 2407.6 2458.4 2488.0 2503.1 2509.6 1931.3 2454.7 2465.6 2477.2 2511.3 2052.4 2162.9 2445.1 2516.6 2520.3 8969.1 8997.0 9000.2 9044.5 9053.6 5261.3 5444.9 5571.1 5627.9 5642.9 3502.8 3573.4 3706.9 3717.7 3718.0 903.0 991.5 1051.2 1086.8 1090.8 9591.8 10624.7 11668.6 12274.3 12325.8 4909.5 4939.2 4955.2 4974.2 4979.4 10331.0 10413.7 10436.8 10468.8 10474.8 4619.7 5529.8 5549.8 5595.1 5595.1 4445.3 4886.2 4996.4 5024.7 5055.6 3961.7 4048.4 4061.8 4083.1 4090.2 1315.6 1336.4 1340.8 1348.8 1350.9 1184.3 1369.0 1406.1 1419.5 1432.2 8200.6 8286.0 8383.8 8486.3 8540.0 512.3 515.3 519.7 520.3 523.0 6296.1 6355.6 6380.2 6381.7 6420.5 10574.7 10946.9 10992.6 11025.9 11038.7 8831.5 10612.7 10809.7 10858.9 10937.0 8425.7 8548.9 8550.3 8559.2 8608.0 6278.4 7996.7 8060.6 8151.1 8185.0 9532.2 9632.5 9734.7 9739.4 9840.5 9872.7 10015.4 10141.9 10154.6 10232.7 6739.6 7464.3 7523.8 7716.7 7765.5 8254.6 8295.9 8321.6 8352.3 8394.4 6403.1 7394.3 7481.1 7577.9 7629.5 6387.3 7321.0 7649.8 7738.4 7744.5 7618.3 7891.7 7942.8 7945.2 7945.5 7071.6 7119.9 7171.1 7190.6 7209.0 7222.1 7300.1 7303.4 7313.2 7341.1 18:51:16 INFO - PROCESS | 1667 | 18:51:16 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5996.92 Median:6800.06 stddev:1986.92 (29.2%) stddev-sans-first:1946.01 18:51:16 INFO - PROCESS | 1667 | Values: 304.2 332.6 334.8 338.1 338.6 6908.7 6957.3 6964.3 6981.8 7021.2 5449.4 6900.9 6906.7 6937.5 6946.5 3991.6 4754.3 5016.1 5039.3 5081.5 4536.8 4596.7 5054.9 5063.8 5065.8 4987.0 4995.6 5002.6 5021.9 5025.6 4440.5 4613.9 5006.0 5008.6 5022.1 4317.4 4327.9 4336.0 4339.5 4350.3 6344.6 6639.5 6664.4 6664.9 6673.3 5840.6 5847.3 5865.0 5881.0 5901.9 7429.4 7436.0 7446.3 7450.1 7486.9 4728.6 4729.6 4732.5 4734.9 4738.3 6109.5 7750.1 7802.0 7836.1 7903.0 4106.7 4585.8 4659.1 4659.8 4766.4 4807.6 4819.8 4822.3 4833.3 4861.2 5827.2 5834.4 5854.0 5854.9 5866.6 7357.4 7405.4 7434.9 7438.7 7451.7 1590.7 1644.9 1655.1 1677.1 1684.1 909.0 949.4 1061.5 1063.1 1067.0 6789.0 6799.9 6823.2 6824.4 6851.5 7642.9 7674.7 7675.8 7692.8 7694.5 5354.1 5885.8 6526.1 6734.9 6800.2 3728.6 4031.8 4059.6 4062.3 4079.4 5694.9 7875.5 8111.6 8146.9 8162.6 6443.4 8063.0 8082.2 8099.6 8119.1 8131.9 8146.4 8154.1 8168.7 8170.0 7558.1 7789.6 7840.8 7857.1 7861.6 7576.4 7628.9 7645.3 7663.7 7669.2 8117.2 8145.5 8154.3 8161.5 8163.6 4805.7 4812.6 4823.8 4827.2 4848.8 7398.6 7769.2 7784.3 7806.3 7847.1 7456.9 7462.1 7481.9 7491.4 7522.4 6000.3 7451.6 7470.6 7481.8 7482.9 6740.2 7219.5 7257.3 7261.4 7277.3 6404.9 7436.7 7486.9 7508.0 7512.8 7260.0 7265.8 7274.7 7284.1 7293.2 18:51:16 INFO - PROCESS | 1667 | 18:51:16 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:17460.81 Median:32382.80 stddev:24824.99 (76.7%) stddev-sans-first:24862.37 18:51:16 INFO - PROCESS | 1667 | Values: 605.8 635.9 666.0 702.6 717.2 14464.6 14682.8 14707.9 14751.5 16550.3 15572.6 15655.0 15708.3 15709.6 15722.7 935.8 947.3 952.2 954.3 954.4 758.3 932.5 946.9 948.5 956.6 720.4 966.0 976.7 981.2 989.0 924.0 972.7 974.8 982.5 983.5 647.7 729.2 733.4 738.0 738.3 15113.0 15226.8 15240.2 15241.6 15260.2 12268.8 12304.4 12305.5 12417.6 12556.6 8113.1 9968.4 10037.1 10111.5 10410.8 3389.8 3392.6 3393.2 3398.2 3399.6 64129.7 79659.0 81496.6 83560.6 83790.0 9006.1 9106.1 9126.9 9183.5 9274.9 19936.8 20101.4 20523.0 20525.4 20580.8 7240.5 7269.6 7274.6 7478.0 7552.8 4021.2 4078.8 4108.7 4119.5 4129.1 3577.2 3599.1 3613.5 3626.5 3638.7 556.7 658.1 666.7 670.4 670.8 465.6 515.9 562.9 567.6 593.5 8066.8 8068.9 8140.7 8182.4 8397.1 490.5 525.4 554.0 559.8 581.1 3299.5 3701.3 3806.3 3838.0 3846.7 89585.6 89736.6 90932.5 90989.5 96261.0 78459.6 79220.4 79399.6 79488.6 80763.6 51927.0 55587.1 59831.5 67917.7 70077.0 5585.3 7545.5 7695.3 7799.8 7961.0 37492.8 41942.8 43843.8 49251.8 49270.5 52265.2 62121.7 65715.0 67240.0 67409.0 9716.6 9777.9 9808.8 10041.4 10111.6 10583.4 10609.9 10679.8 10718.7 11070.3 10080.1 10144.5 10227.5 10349.0 10562.7 10094.7 10153.8 10207.4 10279.6 10376.7 9891.9 9958.4 9997.0 10035.0 10296.9 8643.8 8697.5 8797.9 8834.7 8933.7 8653.1 8692.6 8755.3 8885.6 8899.1 18:51:16 INFO - PROCESS | 1667 | -------- Summary: end -------- 18:51:16 INFO - PROCESS | 1667 | 18:51:16 INFO - TEST-INFO | 1667: exit 0 18:51:16 INFO - TEST-OK | dromaeo_css | took 1111500ms 18:51:16 INFO - TEST-START | kraken 18:51:16 INFO - operating with platform_type : mac_ 18:51:16 INFO - Initialising browser for kraken test... 18:51:16 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmpnTqQ5E/profile http://localhost:49272/getInfo.html) 18:51:19 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 18:51:19 INFO - PROCESS | 1679 | colorDepth:24 18:51:19 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 18:51:19 INFO - PROCESS | 1679 | __metrics 18:51:19 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:51:20 INFO - TEST-INFO | 1679: exit 0 18:51:20 INFO - Browser initialized. 18:51:20 INFO - Running cycle 1/1 for kraken test... 18:51:20 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmpnTqQ5E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:32 INFO - PROCESS | 1682 | RSS: Main: 257015808 18:51:32 INFO - PROCESS | 1682 | 18:51:34 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:35 INFO - PROCESS | 1682 | RSS: Main: 269697024 18:51:35 INFO - PROCESS | 1682 | 18:51:38 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 18:51:38 INFO - PROCESS | 1682 | RSS: Main: 277458944 18:51:38 INFO - PROCESS | 1682 | 18:51:42 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 18:51:42 INFO - PROCESS | 1682 | RSS: Main: 279941120 18:51:42 INFO - PROCESS | 1682 | 18:51:44 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 18:51:45 INFO - PROCESS | 1682 | RSS: Main: 281808896 18:51:45 INFO - PROCESS | 1682 | 18:51:47 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:48 INFO - PROCESS | 1682 | RSS: Main: 283279360 18:51:48 INFO - PROCESS | 1682 | 18:51:50 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:51 INFO - PROCESS | 1682 | RSS: Main: 285130752 18:51:51 INFO - PROCESS | 1682 | 18:51:54 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:54 INFO - PROCESS | 1682 | RSS: Main: 284086272 18:51:54 INFO - PROCESS | 1682 | 18:51:57 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 18:51:58 INFO - PROCESS | 1682 | RSS: Main: 284647424 18:51:58 INFO - PROCESS | 1682 | 18:52:00 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:52:00 INFO - PROCESS | 1682 | RSS: Main: 282718208 18:52:00 INFO - PROCESS | 1682 | 18:52:02 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:52:03 INFO - PROCESS | 1682 | RSS: Main: 283672576 18:52:03 INFO - PROCESS | 1682 | 18:52:05 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:52:05 INFO - PROCESS | 1682 | RSS: Main: 283824128 18:52:05 INFO - PROCESS | 1682 | 18:52:08 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:52:08 INFO - PROCESS | 1682 | RSS: Main: 283340800 18:52:08 INFO - PROCESS | 1682 | 18:52:11 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:52:12 INFO - PROCESS | 1682 | RSS: Main: 285536256 18:52:12 INFO - PROCESS | 1682 | 18:52:13 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 18:52:14 INFO - PROCESS | 1682 | RSS: Main: 285925376 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | __start_tp_report 18:52:14 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 18:52:14 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 18:52:14 INFO - PROCESS | 1682 | |i|pagename|runs| 18:52:14 INFO - PROCESS | 1682 | |0;ai-astar;116;109;114;114;115;125;114;113;114;114 18:52:14 INFO - PROCESS | 1682 | |1;audio-beat-detection;159;110;179;187;155;160;140;124;188;157 18:52:14 INFO - PROCESS | 1682 | |2;audio-dft;200;193;230;254;223;197;193;196;215;231 18:52:14 INFO - PROCESS | 1682 | |3;audio-fft;63;69;69;68;68;143;57;49;64;52 18:52:14 INFO - PROCESS | 1682 | |4;audio-oscillator;88;108;116;76;61;98;158;120;121;145 18:52:14 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;90;85;88;89;90;86;89;86;88;85 18:52:14 INFO - PROCESS | 1682 | |6;imaging-darkroom;94;95;93;94;97;152;103;96;94;95 18:52:14 INFO - PROCESS | 1682 | |7;imaging-desaturate;92;85;148;149;145;91;91;91;92;93 18:52:14 INFO - PROCESS | 1682 | |8;json-parse-financial;56;54;55;53;56;54;56;60;65;68 18:52:14 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;65;66;70;75;108;70;64;65;66;67 18:52:14 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;85;87;83;87;85;86;85;85;88;82 18:52:14 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;127;124;125;132;121;125;121;130;133;120 18:52:14 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;136;139;141;138;149;144;126;162;183;176 18:52:14 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;69;65;67;68;67;68;65;68;68;67 18:52:14 INFO - PROCESS | 1682 | __end_tp_report 18:52:14 INFO - PROCESS | 1682 | __start_cc_report 18:52:14 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,915 18:52:14 INFO - PROCESS | 1682 | __end_cc_report 18:52:14 INFO - PROCESS | 1682 | __startTimestamp1457146334063__endTimestamp 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | ------- Summary: start ------- 18:52:14 INFO - PROCESS | 1682 | Number of tests: 14 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.00 stddev:4.02 (3.5%) stddev-sans-first:4.24 18:52:14 INFO - PROCESS | 1682 | Values: 116.0 109.0 114.0 114.0 115.0 125.0 114.0 113.0 114.0 114.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:159.50 stddev:25.68 (16.1%) stddev-sans-first:27.22 18:52:14 INFO - PROCESS | 1682 | Values: 159.0 110.0 179.0 187.0 155.0 160.0 140.0 124.0 188.0 157.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:213.20 Median:219.00 stddev:20.85 (9.5%) stddev-sans-first:21.56 18:52:14 INFO - PROCESS | 1682 | Values: 200.0 193.0 230.0 254.0 223.0 197.0 193.0 196.0 215.0 231.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:70.20 Median:66.00 stddev:26.58 (40.3%) stddev-sans-first:28.06 18:52:14 INFO - PROCESS | 1682 | Values: 63.0 69.0 69.0 68.0 68.0 143.0 57.0 49.0 64.0 52.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:109.50 stddev:29.75 (27.2%) stddev-sans-first:30.56 18:52:14 INFO - PROCESS | 1682 | Values: 88.0 108.0 116.0 76.0 61.0 98.0 158.0 120.0 121.0 145.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.96 (2.2%) stddev-sans-first:1.87 18:52:14 INFO - PROCESS | 1682 | Values: 90.0 85.0 88.0 89.0 90.0 86.0 89.0 86.0 88.0 85.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:94.50 stddev:18.04 (19.1%) stddev-sans-first:18.94 18:52:14 INFO - PROCESS | 1682 | Values: 94.0 95.0 93.0 94.0 97.0 152.0 103.0 96.0 94.0 95.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:107.70 Median:91.00 stddev:27.45 (30.2%) stddev-sans-first:28.52 18:52:14 INFO - PROCESS | 1682 | Values: 92.0 85.0 148.0 149.0 145.0 91.0 91.0 91.0 92.0 93.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:56.00 stddev:5.06 (9.0%) stddev-sans-first:5.33 18:52:14 INFO - PROCESS | 1682 | Values: 56.0 54.0 55.0 53.0 56.0 54.0 56.0 60.0 65.0 68.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:66.50 stddev:13.21 (19.9%) stddev-sans-first:13.79 18:52:14 INFO - PROCESS | 1682 | Values: 65.0 66.0 70.0 75.0 108.0 70.0 64.0 65.0 66.0 67.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:1.83 (2.1%) stddev-sans-first:1.94 18:52:14 INFO - PROCESS | 1682 | Values: 85.0 87.0 83.0 87.0 85.0 86.0 85.0 85.0 88.0 82.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.00 stddev:4.64 (3.7%) stddev-sans-first:4.90 18:52:14 INFO - PROCESS | 1682 | Values: 127.0 124.0 125.0 132.0 121.0 125.0 121.0 130.0 133.0 120.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:146.50 stddev:18.44 (12.6%) stddev-sans-first:18.91 18:52:14 INFO - PROCESS | 1682 | Values: 136.0 139.0 141.0 138.0 149.0 144.0 126.0 162.0 183.0 176.0 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.32 (1.9%) stddev-sans-first:1.22 18:52:14 INFO - PROCESS | 1682 | Values: 69.0 65.0 67.0 68.0 67.0 68.0 65.0 68.0 68.0 67.0 18:52:14 INFO - PROCESS | 1682 | -------- Summary: end -------- 18:52:14 INFO - PROCESS | 1682 | 18:52:14 INFO - TEST-INFO | 1682: exit 0 18:52:14 INFO - TEST-OK | kraken | took 57909ms 18:52:14 INFO - SUITE-END | took 1169s 18:52:15 INFO - Completed test suite (00:19:29) 18:52:15 INFO - javascript benchmark 18:52:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2943.0729320264118, 3480.095175254434, 3533.3110043541506, 3565.251297227582, 3568.821558922053, 4466.3523789050605, 5639.295088113986, 5789.681567513785, 5792.391798861122, 5816.534677225823, 4604.447466304048, 5831.416858314166, 5851.444112809277, 5888.764449422018, 5892.322382925965, 4787.8324258650955, 5222.973885130569, 5241.397239317489, 5398.568114550846, 5406.243125962368, 3839.9824046627664, 4537.863864084083, 4999.850004499871, 5297.0, 5323.121684921984, 3942.4283478895545, 5197.610179236553, 5215.295935048758, 5276.5251127398715, 5321.308229930123, 4188.4555007849085, 5218.243354713545, 5239.21411788231, 5245.396779370345, 5305.018571564273, 5173.663711858717, 5178.766955487012, 5224.555912747421, 5246.31797866275, 5260.947390526084, 4202.831886724527, 5640.153976903456, 5696.287964004499, 5710.65736055838, 5732.398098199712, 6182.629042257479, 6240.344763799781, 6252.531060170505, 6290.402411770874, 6301.87396252077, 5749.511291540182, 6154.5384096192965, 6180.783672571483, 6227.439530442282, 6353.523485738542, 5927.762889484372, 5931.051031834886, 5944.197533333031, 5949.6430214187285, 6006.78976235834, 5369.167778994262, 6367.395097465734, 6370.299267080617, 6370.426661600478, 6381.074744162071, 6075.179850720185, 6117.949202904643, 6167.814965551041, 6205.410486003822, 6213.099100630474, 6138.878900475427, 6185.917464443704, 6190.1952746142715, 6239.656818875005, 6241.063840423973, 6126.9387306127255, 6184.628922264678, 6236.688165591793, 6244.531660125509, 6247.437730604267, 5076.314697515862, 6153.84615384619, 6175.197224360804, 6276.529260305495, 6286.9056964145575, 4930.112579735682, 4932.630052746058, 4935.531124543163, 4952.133376659142, 4961.578265847371, 4437.112577484516, 4446.755428451402, 4451.866444006685, 4459.0, 4464.107178564235, 5546.334439867242, 5750.6262092963825, 5769.07694768835, 5849.736761845727, 5856.94143058564, 6200.937990620127, 6204.627722336584, 6240.781572644935, 6241.937580624226, 6244.0, 5539.362973258047, 5798.565107616945, 5807.535397168216, 5820.097884827858, 5824.446677565625, 5304.283921670525, 5396.168720208696, 5447.5641948644015, 5450.1007333789485, 5500.917486237709, 6438.313978323684, 6467.773627923, 6472.805815825533, 6474.643894585843, 6486.189226346707, 4971.65198436106, 6273.905891411724, 6274.811755647338, 6278.15244941927, 6284.937150628618, 6378.553501254868, 6428.517861160338, 6465.0948867157695, 6494.772682956074, 6501.122348482894, 6176.135341052166, 6249.0626406039455, 6255.874882502233, 6258.499320054476, 6272.435480806749, 6162.890679677701, 6188.257409110935, 6256.311805701278, 6261.530385221035, 6264.968675156595, 5091.821786237464, 5764.13537969308, 5953.196318497121, 6008.669523176267, 6123.1606109212, 6154.353792851686, 6199.845003874939, 6223.471004964629, 6223.875522489616, 6228.844278893064, 5313.574914006947, 5679.290088738908, 5723.284589426322, 6010.158577799024, 6018.277806663228, 5003.799848006039, 6142.959235178615, 6190.41191086846, 6205.0, 6218.5647004709235, 5282.392524859691, 6021.729022193924, 6080.48315893154, 6093.664848433379, 6123.112148738319], "unit": "score", "name": "dojo.html", "value": 5649.098535271718}, {"lowerIsBetter": false, "replicates": [403.27611936573845, 487.23990574703464, 547.7699366266168, 600.3006497430493, 644.0339490763854, 38146.42780358297, 38675.03312417184, 38710.8064459678, 38737.612623873756, 38794.80602596987, 41897.16205675892, 42371.0, 42428.15143697124, 42511.9372015699, 42567.0, 8213.726872334797, 9569.0, 9641.855372169388, 9677.129058384744, 9732.56203470842, 9571.138597526222, 9695.127438530531, 9723.27075469339, 9725.51372431379, 9726.70819875405, 9648.517574121266, 9700.272479564026, 9739.464329461876, 9753.756156096084, 9776.071273229067, 9630.0, 9691.418514889128, 9727.221822254203, 9762.560684769202, 9770.316077874551, 9510.572024258925, 9634.566444510014, 9652.179564737005, 9673.322867399285, 9687.903120968771, 39309.60690393117, 39623.603763962565, 39784.0, 39859.0, 39883.40174897379, 3181.2046988252937, 3301.4552598821165, 3429.477747796723, 3476.3047390521997, 3814.8855534334016, 23092.42268943273, 29155.41689166226, 29621.555676664866, 29995.40009199804, 30494.0, 2697.8381297122237, 2737.301987993069, 2752.678714217187, 2801.089645865102, 2892.47935371633, 461351.0, 461717.0, 465683.6715816433, 466143.0, 466501.9999999966, 45201.38388928878, 65110.674446628414, 65178.34821651818, 65585.67207163933, 65793.34206657967, 46157.7692111544, 46272.30591541129, 46289.53710462852, 46549.0, 46561.603151905496, 15701.214939253221, 15807.446739364066, 15853.207339632972, 15871.12708801004, 15906.204689765465, 10720.303180293256, 12320.383980801103, 12700.110992230455, 12750.426230819636, 12756.80864787029, 14923.70152596942, 14942.551723448314, 15293.0, 15358.310585835548, 15375.308111135026, 5425.059559782032, 6636.402723754885, 6705.329467053353, 6711.563748356439, 6727.058211850345, 1009.4498498318287, 1015.0002247785925, 1057.281048886749, 1138.1293310617384, 1157.9636225578229, 29747.620190384718, 29948.85025574858, 30273.0, 30356.696433035828, 30393.69606303953, 1070.3203465799274, 1118.3960661243, 1162.8255761635653, 1194.199886076331, 1232.4471166330488, 11957.282563046245, 14478.565643030726, 14484.85515144835, 14761.40954361835, 14933.70132597342, 341999.0, 435142.0, 437191.0, 437801.0, 440071.0, 58969.41030589725, 60938.0, 61325.693371532856, 61358.77282454326, 61376.693116535025, 1440.481426686392, 1482.770170623555, 1489.6871656951944, 1500.6998600279987, 1504.6840163565555, 22511.64930104199, 29443.411131777673, 29545.704542955154, 29837.403251935273, 30274.394512110073, 53758.73120634372, 53827.730861345444, 53929.0, 54093.91812163813, 54307.72846135744, 453962.730186347, 479816.0, 479861.0, 483661.0, 484358.1564184313, 27463.588046179724, 33781.83109084439, 33962.320753584296, 34133.82933085319, 34528.48207276943, 36252.81873590615, 45585.544144559455, 46290.76854615705, 46825.0, 47585.0, 37009.0, 38170.85487435381, 38342.0, 38920.80539597284, 38999.6100038996, 35018.949431517096, 37527.87416377513, 37648.623513765604, 38014.0, 38470.0, 36978.815105924295, 37237.88286351414, 37462.8126859364, 38000.429993549566, 38313.0, 26053.609195862457, 32903.83548082244, 32981.50527742134, 33368.33263334671, 33692.83153584216, 24944.12695555647, 24988.75011249864, 25043.419409097543, 25305.74694253034, 25565.3608659785], "unit": "score", "name": "ext.html", "value": 19268.276813470424}, {"lowerIsBetter": false, "replicates": [355.948387483815, 365.73118757713087, 367.94480827875833, 369.7467234944065, 371.74535443221384, 19399.0, 19785.307514237003, 20887.895560522215, 21043.579128417423, 21064.789352106476, 20605.690914636292, 20633.690494642593, 20932.267370642032, 21083.262085827, 21179.94100294987, 5692.857678558028, 5916.733746981375, 5949.970250148744, 5957.255343082114, 5961.284645842505, 5480.862978425552, 5764.106563482667, 5767.990601644696, 5770.624909380897, 5807.82576522705, 5642.351129620105, 5733.655980641154, 5752.137179423078, 5766.250387449647, 5964.314103878066, 5909.084091965752, 5909.497692696126, 5930.762769489237, 5959.642421454727, 5971.552133589998, 5607.299087614048, 5669.773209071632, 5682.715864206773, 5687.459691329317, 5687.914681279743, 13084.21494710311, 13293.800592991112, 13393.531226407127, 13470.124441911343, 13559.0, 1978.429827099405, 1996.5308152584132, 2114.450242936832, 2277.6355783074796, 2721.877515511807, 9632.229421646252, 9707.417554946725, 9976.750581235527, 10076.949615251877, 10241.948790256076, 1697.719876220422, 1721.208244207666, 1727.265911987413, 1733.5319463744845, 1780.3857669104138, 102267.0, 105945.47027264969, 106486.33784155457, 106678.0, 106780.46609766902, 11263.718407039889, 11430.856914308502, 11506.539738410538, 11514.251573647685, 11672.416379181008, 13883.236421996888, 13930.512432064828, 13935.233562154179, 13937.58187254384, 13943.0, 7747.806304842311, 7976.760697179094, 8649.567521623894, 8652.264557512555, 8730.781730456662, 8747.0, 8761.474311541328, 8775.0, 8824.205821476098, 8862.158094980967, 4436.46762388509, 4548.204064288736, 4564.0, 4576.633869290449, 4604.700694454849, 1580.2730743857953, 1617.951461456158, 1925.8266755991747, 1950.8439324853978, 1953.1210955070276, 941.5433514745343, 949.2548349545574, 954.8376775948105, 1018.3991445047458, 1028.5422986770816, 19368.322108726126, 19387.806121938884, 19844.0, 20194.59610807805, 20421.285255016002, 876.8903887014123, 888.2094935507274, 909.4088842252456, 976.5068640336584, 1040.557762950743, 9490.446177722535, 10536.631217907336, 10726.302790318605, 10828.566857325619, 10866.348019118877, 491030.6345404822, 509046.0, 536994.0, 623069.0, 640613.0, 58089.128663070085, 88591.0, 94337.0, 117804.0, 123651.38174309251, 973.9659111931048, 994.8457989011715, 1011.2163073618005, 1011.2415688233824, 1013.5844303835393, 17725.734113988558, 17908.373206937693, 18146.546336341697, 18191.45425637233, 18215.45353639393, 32625.836870816445, 38762.0, 48026.27960580664, 52309.95380092453, 52629.473705262455, 68238.0, 72139.0, 73285.6335718318, 74140.62929685533, 76418.8537171954, 6602.537822352389, 6768.9661551691925, 7823.178566250689, 7854.803629909069, 8021.398395120506, 10863.891361086287, 13261.204327740366, 13330.266835323762, 13732.0, 13818.723625527635, 10116.797664046531, 11193.104551636012, 11295.096392288762, 11434.656960291204, 11475.483603237708, 11230.7753844921, 11242.213045086766, 11481.425928703698, 11547.364894930524, 11580.552430946133, 11603.535858565563, 11771.764564708828, 11900.107491937966, 11985.820212696992, 12075.335856527623, 6551.344865513411, 7904.6838126474295, 7934.801629959297, 8054.395920305883, 8213.466124701876, 8396.076431592397, 10623.734406639587, 11631.76736465283, 11903.047756179658, 11949.342786146846], "unit": "score", "name": "jquery.html", "value": 9143.227900733276}, {"lowerIsBetter": false, "replicates": [1631.1273468694246, 1645.8518733314004, 1947.8539109566777, 2025.1696804310227, 2027.2195204846148, 7998.560079195642, 8608.225259726623, 8791.956040219799, 8958.910410895889, 8983.281337493001, 8788.692395766133, 8795.252403545706, 8877.55612219388, 8884.822303553925, 8913.554322283891, 2458.9262322130367, 2468.469279104992, 2489.3403248139257, 2492.9252122436264, 2498.8250822442437, 2435.8782060896974, 2491.302435318114, 2501.9874900625564, 2504.486580251044, 2506.385935445809, 2407.590709579367, 2458.373114855718, 2487.962680559793, 2503.086373473678, 2509.6110102934076, 1931.3240365871973, 2454.7054353477606, 2465.6055031195015, 2477.170148000422, 2511.259178542334, 2052.404802607242, 2162.902669379882, 2445.058652418814, 2516.6350879122606, 2520.3069155982066, 8969.103089691043, 8996.955015224947, 9000.189982901506, 9044.457332560001, 9053.59258833354, 5261.342332208474, 5444.863878403072, 5571.13647384656, 5627.943720562783, 5642.943570564283, 3502.8423720932365, 3573.4103872860946, 3706.9073273168115, 3717.739758216926, 3717.962820371789, 902.9954850225772, 991.5092029445399, 1051.2483574244375, 1086.8369744538304, 1090.7763908398758, 9591.760205994837, 10624.671916010499, 11668.591599294068, 12274.263544187288, 12325.815112773316, 4909.459959404463, 4939.185034469272, 4955.207166853286, 4974.1543937530705, 4979.427365852901, 10331.0, 10413.739656508647, 10436.843447348145, 10468.842967355497, 10474.790504189874, 4619.722816631013, 5529.778808847601, 5549.833504994856, 5595.132754423071, 5595.132754423071, 4445.310976798537, 4886.193778026586, 4996.4254110777, 5024.748762561857, 5055.595552355876, 3961.6830653547645, 4048.3927410888014, 4061.817218225187, 4083.1425400666194, 4090.202410529918, 1315.6316231455207, 1336.385262779113, 1340.7921772125337, 1348.797680347936, 1350.864913508661, 1184.324934787163, 1369.0, 1406.1282005156663, 1419.531554586984, 1432.2194404049817, 8200.630971606291, 8286.0, 8383.790405239795, 8486.32109431244, 8540.0, 512.3314075131914, 515.2554558662696, 519.6855902179203, 520.3339725151811, 522.9921551176735, 6296.118543403927, 6355.586886852339, 6380.202474690664, 6381.744730210739, 6420.454261387741, 10574.735631609117, 10946.890531094747, 10992.615258466076, 11025.889741102486, 11038.668839934815, 8831.514266715263, 10612.681619551426, 10809.729756755987, 10858.891411085788, 10937.0, 8425.662973480992, 8548.871766923501, 8550.315974722133, 8559.186877246651, 8608.010078841013, 6278.4035516625845, 7996.680132794623, 8060.637271322922, 8151.144129866516, 8185.0, 9532.189763870148, 9632.518374081128, 9734.707958761248, 9739.366941148803, 9840.458774767456, 9872.654457093968, 10015.39907605546, 10141.949290253502, 10154.644587439405, 10232.744181395525, 6739.5619284746335, 7464.328210461084, 7523.811904702207, 7716.691332346868, 7765.495242809199, 8254.637984732692, 8295.875561866456, 8321.583920804056, 8352.33181345503, 8394.412391132562, 6403.135576697086, 7394.2975417335265, 7481.064866891638, 7577.924220757943, 7629.504082234859, 6387.265464471645, 7321.0, 7649.808754780953, 7738.419618528746, 7744.535327880345, 7618.276263754934, 7891.68433262686, 7942.761717148494, 7945.24520170606, 7945.523268603903, 7071.611061391673, 7119.8932016020835, 7171.103612048494, 7190.604516751629, 7209.026781384446, 7222.09723784527, 7300.12398512182, 7303.415726741954, 7313.23211062852, 7341.082364704412], "unit": "score", "name": "mootools.html", "value": 4899.845997873796}, {"lowerIsBetter": false, "replicates": [304.19692013085455, 332.5593588495244, 334.807485695725, 338.1343759974464, 338.63089232736314, 6908.654567271635, 6957.269486703893, 6964.303569643033, 6981.790546283607, 7021.22766495685, 5449.373322067963, 6900.861982760342, 6906.723731050764, 6937.479689023318, 6946.513744037907, 3991.6407523322896, 4754.334393184957, 5016.122178618745, 5039.294498770175, 5081.46644602317, 4536.818527258923, 4596.747178905159, 5054.9241761373605, 5063.8480845574695, 5065.848024559269, 4986.975065124688, 4995.6003519718515, 5002.599792016648, 5021.949780502185, 5025.572826309768, 4440.533743956887, 4613.861584152481, 5006.0, 5008.599312055063, 5022.121128802463, 4317.352397140423, 4327.913441731148, 4336.0, 4339.457567804025, 4350.282203436429, 6344.619322840645, 6639.502037347218, 6664.400203981617, 6664.866702665968, 6673.332666733337, 5840.591158618899, 5847.26909136358, 5864.970675146639, 5880.97059514704, 5901.911471327933, 7429.368503677194, 7436.0, 7446.340781006474, 7450.105987281561, 7486.9251307486775, 4728.598069164125, 4729.6452766042685, 4732.503087175865, 4734.928976065362, 4738.265568836836, 6109.511239100906, 7750.14748377678, 7802.0, 7836.138024817265, 7903.0, 4106.726914656466, 4585.79363928624, 4659.114768194032, 4659.767011649404, 4766.380370551876, 4807.6153907688, 4819.807207711722, 4822.348982887335, 4833.299171620095, 4861.222204447342, 5827.1841942127285, 5834.416558344132, 5854.0, 5854.912176317359, 5866.560007999417, 7357.448191385667, 7405.444591655647, 7434.925650743423, 7438.73964411243, 7451.664675089634, 1590.6898154859691, 1644.9342026319052, 1655.0731590309465, 1677.0692265792359, 1684.1242553871919, 908.9500077495801, 949.4445749236636, 1061.490484567412, 1063.1176123817213, 1066.989330106689, 6789.0, 6799.932000680029, 6823.1812182538415, 6824.385805277549, 6851.45188384928, 7642.923570764221, 7674.654640541189, 7675.846483070307, 7692.807679807937, 7694.499857509244, 5354.089804733127, 5885.76398956224, 6526.086347911296, 6734.8653026940165, 6800.183977922681, 3728.6271372862498, 4031.798410079543, 4059.6143366380147, 4062.3297155968935, 4079.4084857695466, 5694.914576281359, 7875.488093273919, 8111.634976426075, 8146.940897683382, 8162.551059691656, 6443.387878151568, 8063.0, 8082.19178082187, 8099.554524501209, 8119.106898241189, 8131.878021829677, 8146.389020823462, 8154.143814899468, 8168.673253069811, 8169.959150204211, 7558.13081495635, 7789.610519474117, 7840.803979900548, 7857.135715071223, 7861.567613781068, 7576.3938884887975, 7628.8938103973505, 7645.273698998586, 7663.655135519027, 7669.233076692286, 8117.228863257981, 8145.51126932386, 8154.306883914696, 8161.510309381219, 8163.632636531252, 4805.687630304019, 4812.590929771009, 4823.831165909176, 4827.155247831545, 4848.781804818721, 7398.630068496446, 7769.223077692185, 7784.260495252942, 7806.336461400844, 7847.058352997677, 7456.888146677913, 7462.067241594801, 7481.887771683538, 7491.3632341251605, 7522.435817313833, 6000.279966404059, 7451.627418629156, 7470.6264686766535, 7481.812954676177, 7482.887756683763, 6740.157480314961, 7219.45854060937, 7257.346838784535, 7261.38278246355, 7277.2722727726805, 6404.9039264412, 7436.665350059152, 7486.850262994819, 7508.0, 7512.849743005, 7259.963700181465, 7265.818354540967, 7274.672639731119, 7284.053073100463, 7293.234210407831], "unit": "score", "name": "prototype.html", "value": 5323.233619924641}, {"lowerIsBetter": false, "replicates": [605.818254523643, 635.9300476947535, 665.980020599382, 702.5924963521159, 717.2268552781243, 14464.638384040405, 14682.779758303634, 14707.92646036771, 14751.48369807057, 16550.337986480557, 15572.610684732887, 15655.0, 15708.293126809293, 15709.607259818482, 15722.685546289067, 935.8362286599852, 947.275334369208, 952.2286947572454, 954.265215783846, 954.3558098283665, 758.2682711183706, 932.5104320231865, 946.9479178645172, 948.5115165689675, 956.6173530587786, 720.4056653261055, 965.9661911833088, 976.7460460280307, 981.1807141037242, 988.9554970026367, 923.9769005774842, 972.6838777397375, 974.7611835100375, 982.5136557404095, 983.4836710726854, 647.6632151281354, 729.2160927003439, 733.3509843788232, 737.9926200737978, 738.2506755643027, 15113.017653852574, 15226.847731522765, 15240.23798810055, 15241.61895952599, 15260.236988150547, 12268.815967760402, 12304.384780760925, 12305.50777968889, 12417.62747117588, 12556.623301300975, 8113.077453458949, 9968.40189588627, 10037.146842518394, 10111.494425278706, 10410.843837342445, 3389.8305084745666, 3392.6098498672723, 3393.2195595013286, 3398.1844357354303, 3399.6090449598364, 64129.67935160341, 79659.0, 81496.59251703763, 83560.58219708923, 83790.0, 9006.144416280444, 9106.089391060841, 9126.908730912739, 9183.494907780136, 9274.860877086849, 19936.800631993785, 20101.39695809128, 20523.0, 20525.38423847287, 20580.794192058187, 7240.52936559122, 7269.600171990592, 7274.636268186569, 7478.027856378745, 7552.811179720551, 4021.1957608477837, 4078.7552746835286, 4108.712390132662, 4119.485064366954, 4129.050318426779, 3577.195131095483, 3599.1002249437643, 3613.457981302826, 3626.492291079251, 3638.6725194732603, 556.7445410599073, 658.1246941567704, 666.74330382802, 670.3698523388, 670.8322919270182, 465.5623713709103, 515.943246242913, 562.8817948230835, 567.633876149881, 593.4599514441837, 8066.838663226703, 8068.878966815502, 8140.715074972348, 8182.386321025947, 8397.076321604618, 490.49724032866595, 525.3957948359341, 553.9861503462446, 559.7509108446784, 581.1457157977766, 3299.5050742388353, 3701.333759923186, 3806.276807406584, 3838.0021194489077, 3846.653801157909, 89585.55207223922, 89736.5513172443, 90932.54533727422, 90989.54505227432, 96261.0, 78459.60770196113, 79220.415591689, 79399.60300198462, 79488.60255698685, 80763.59618201871, 51926.96146077057, 55587.05161854768, 59831.50421239504, 67917.66041169861, 70077.0, 5585.3297604287745, 7545.50954187976, 7695.345895598937, 7799.844003120019, 7960.960195198987, 37492.81253593715, 41942.790286048374, 43843.78078109589, 49251.7537412325, 49270.50729492803, 52265.21602176046, 62121.689391552754, 65715.0, 67240.0, 67409.0, 9716.611335546499, 9777.853332200166, 9808.803823923625, 10041.397516149054, 10111.59553617847, 10583.364998100138, 10609.9469502652, 10679.839802403125, 10718.73203169927, 11070.28043177191, 10080.092791648787, 10144.54349554257, 10227.488625568543, 10349.016843399864, 10562.735931601772, 10094.697159085239, 10153.796924061626, 10207.387556746618, 10279.588816447258, 10376.740581485523, 9891.901080989099, 9958.44833942846, 9997.000299969945, 10035.046670566284, 10296.948515257376, 8643.783905402415, 8697.521636310064, 8797.912020879965, 8834.734957951272, 8933.687320943736, 8653.091425400242, 8692.565371731262, 8755.343349248704, 8885.555722213734, 8899.110088991049], "unit": "score", "name": "yui.html", "value": 6635.740870552147}], "name": "dromaeo_css", "value": 7459.339356970071}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 109.0, 114.0, 114.0, 115.0, 125.0, 114.0, 113.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [159.0, 110.0, 179.0, 187.0, 155.0, 160.0, 140.0, 124.0, 188.0, 157.0], "unit": "score", "name": "audio-beat-detection", "value": 155.9}, {"lowerIsBetter": true, "replicates": [200.0, 193.0, 230.0, 254.0, 223.0, 197.0, 193.0, 196.0, 215.0, 231.0], "unit": "score", "name": "audio-dft", "value": 213.2}, {"lowerIsBetter": true, "replicates": [63.0, 69.0, 69.0, 68.0, 68.0, 143.0, 57.0, 49.0, 64.0, 52.0], "unit": "score", "name": "audio-fft", "value": 70.2}, {"lowerIsBetter": true, "replicates": [88.0, 108.0, 116.0, 76.0, 61.0, 98.0, 158.0, 120.0, 121.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [90.0, 85.0, 88.0, 89.0, 90.0, 86.0, 89.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 93.0, 94.0, 97.0, 152.0, 103.0, 96.0, 94.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 101.3}, {"lowerIsBetter": true, "replicates": [92.0, 85.0, 148.0, 149.0, 145.0, 91.0, 91.0, 91.0, 92.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 107.7}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 55.0, 53.0, 56.0, 54.0, 56.0, 60.0, 65.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 70.0, 75.0, 108.0, 70.0, 64.0, 65.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.6}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 83.0, 87.0, 85.0, 86.0, 85.0, 85.0, 88.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [127.0, 124.0, 125.0, 132.0, 121.0, 125.0, 121.0, 130.0, 133.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [136.0, 139.0, 141.0, 138.0, 149.0, 144.0, 126.0, 162.0, 183.0, 176.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [69.0, 65.0, 67.0, 68.0, 67.0, 68.0, 65.0, 68.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1516.8000000000002}]} 18:52:15 INFO - Return code: 0 18:52:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:52:15 ERROR - # TBPL SUCCESS # 18:52:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:52:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:52:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:52:15 INFO - 2016-03-04 18:52:15.376 screenresolution[1687:10698] starting screenresolution argv=screenresolution get 18:52:15 INFO - 2016-03-04 18:52:15.379 screenresolution[1687:10698] Display 0: 1600x1200x32@60 18:52:15 INFO - 2016-03-04 18:52:15.385 screenresolution[1688:10701] starting screenresolution argv=screenresolution list 18:52:15 INFO - Available Modes on Display 0 18:52:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:52:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:52:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:52:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:52:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:52:15 INFO - Intel Iris: 18:52:15 INFO - Chipset Model: Intel Iris 18:52:15 INFO - Type: GPU 18:52:15 INFO - Bus: Built-In 18:52:15 INFO - VRAM (Dynamic, Max): 1536 MB 18:52:15 INFO - Vendor: Intel (0x8086) 18:52:15 INFO - Device ID: 0x0a2e 18:52:15 INFO - Revision ID: 0x0009 18:52:15 INFO - Displays: 18:52:15 INFO - Display: 18:52:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:52:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:52:15 INFO - Display Serial Number: 1600x1200 60 18:52:15 INFO - Main Display: Yes 18:52:15 INFO - Mirror: Off 18:52:15 INFO - Online: Yes 18:52:15 INFO - Rotation: Supported 18:52:15 INFO - Return code: 0 18:52:15 INFO - Running post-action listener: _resource_record_post_action 18:52:15 INFO - Running post-run listener: _resource_record_post_run 18:52:16 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 39683584; Write bytes: 708364288; Read time: 428; Write time: 2171 18:52:16 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398637568; Write bytes: 392804352; Read time: 30372; Write time: 745 18:52:16 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37885440; Write bytes: 303947776; Read time: 408; Write time: 1392 18:52:16 INFO - Running post-run listener: _upload_blobber_files 18:52:16 INFO - Blob upload gear active. 18:52:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:52:16 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 18:52:16 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'] 18:52:16 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 18:52:17 INFO - (blobuploader) - INFO - Open directory for files ... 18:52:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:52:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:18 INFO - (blobuploader) - INFO - Done attempting. 18:52:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:52:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:52:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:19 INFO - (blobuploader) - INFO - Done attempting. 18:52:19 INFO - (blobuploader) - INFO - Iteration through files over. 18:52:19 INFO - Return code: 0 18:52:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:52:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:52:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c591c6eb539f078c05adea00e2eca411d29e4c2935c05c4038403cf5c0c642a1a5a1b93d7da8069eba182066d55547083fc6ca1da9b5dd61eeb85a17b5067615", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb00bd6e71908b20c3b1bd2315ca95ae55b701c9a3c87580a49fd5cebba2e1917ac0eb94082389bec714bde221f893dbb439ed8213e626efefe349b01da317f"} 18:52:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:52:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:52:19 INFO - Contents: 18:52:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c591c6eb539f078c05adea00e2eca411d29e4c2935c05c4038403cf5c0c642a1a5a1b93d7da8069eba182066d55547083fc6ca1da9b5dd61eeb85a17b5067615", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb00bd6e71908b20c3b1bd2315ca95ae55b701c9a3c87580a49fd5cebba2e1917ac0eb94082389bec714bde221f893dbb439ed8213e626efefe349b01da317f"} 18:52:19 INFO - Running post-run listener: copy_logs_to_upload_dir 18:52:19 INFO - Copying logs to upload dir... 18:52:19 INFO - mkdir: /builds/slave/test/build/upload/logs 18:52:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.289308 ========= master_lag: 5.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-04 18:52:24.956978) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 18:52:24.965008) ========= 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.DxQsqdX3jz/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.p621HLrCY6/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/c591c6eb539f078c05adea00e2eca411d29e4c2935c05c4038403cf5c0c642a1a5a1b93d7da8069eba182066d55547083fc6ca1da9b5dd61eeb85a17b5067615", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb00bd6e71908b20c3b1bd2315ca95ae55b701c9a3c87580a49fd5cebba2e1917ac0eb94082389bec714bde221f893dbb439ed8213e626efefe349b01da317f"} build_url:https://queue.taskcluster.net/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011023 build_url: 'https://queue.taskcluster.net/v1/task/QWDN3FC0Spa76pCf-e2VFA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c591c6eb539f078c05adea00e2eca411d29e4c2935c05c4038403cf5c0c642a1a5a1b93d7da8069eba182066d55547083fc6ca1da9b5dd61eeb85a17b5067615", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb00bd6e71908b20c3b1bd2315ca95ae55b701c9a3c87580a49fd5cebba2e1917ac0eb94082389bec714bde221f893dbb439ed8213e626efefe349b01da317f"}' ========= master_lag: 0.75 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 18:52:25.726088) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:52:25.732452) ========= 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.DxQsqdX3jz/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.p621HLrCY6/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.005334 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 18:52:25.774012) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 18:52:25.774323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 18:52:25.781477) ========= ========= Total master_lag: 6.34 =========