builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0192 starttime: 1457598310.48 results: success (0) buildid: 20160309233121 builduid: 20b810b7e01d454cb295a8231df089ab revision: f7abc73ebddbff1d47753051faafda94c61916c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.483754) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.484194) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.484503) ========= 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.daiMr2COte/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.jZfynUqwKg/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005701 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.512798) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.516156) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.533516) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.533831) ========= 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.daiMr2COte/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.jZfynUqwKg/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005776 ========= master_lag: 0.32 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.861399) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.861752) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.865174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:10.865476) ========= 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.daiMr2COte/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.jZfynUqwKg/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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-10 00:25:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.9M=0.001s 2016-03-10 00:25:11 (15.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160129 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:11.041823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:11.042570) ========= 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.daiMr2COte/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.jZfynUqwKg/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.027241 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:11.091740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 00:25:11.092507) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f7abc73ebddbff1d47753051faafda94c61916c3 --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 f7abc73ebddbff1d47753051faafda94c61916c3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.daiMr2COte/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.jZfynUqwKg/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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-10 00:25:11,173 truncating revision to first 12 chars 2016-03-10 00:25:11,173 Setting DEBUG logging. 2016-03-10 00:25:11,173 attempt 1/10 2016-03-10 00:25:11,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f7abc73ebddb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 00:25:12,154 unpacking tar archive at: fx-team-f7abc73ebddb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.243162 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 00:25:12.353280) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:12.353743) ========= echo f7abc73ebddbff1d47753051faafda94c61916c3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f7abc73ebddbff1d47753051faafda94c61916c3'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.daiMr2COte/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.jZfynUqwKg/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 f7abc73ebddbff1d47753051faafda94c61916c3 program finished with exit code 0 elapsedTime=0.005478 script_repo_revision: 'f7abc73ebddbff1d47753051faafda94c61916c3' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:12.403893) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:12.404207) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 00:25:12.417885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-10 00:25:12.418156) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.daiMr2COte/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.jZfynUqwKg/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 00:25:12 INFO - MultiFileLogger online at 20160310 00:25:12 in /builds/slave/test 00:25:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:25:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:25:12 INFO - {'append_to_log': False, 00:25:12 INFO - 'base_work_dir': '/builds/slave/test', 00:25:12 INFO - 'blob_upload_branch': 'Fx-Team', 00:25:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:25:12 INFO - 'branch': 'Fx-Team', 00:25:12 INFO - 'buildbot_json_path': 'buildprops.json', 00:25:12 INFO - 'config_files': ('talos/mac_config.py',), 00:25:12 INFO - 'default_actions': ('clobber', 00:25:12 INFO - 'read-buildbot-config', 00:25:12 INFO - 'download-and-extract', 00:25:12 INFO - 'populate-webroot', 00:25:12 INFO - 'create-virtualenv', 00:25:12 INFO - 'install', 00:25:12 INFO - 'run-tests'), 00:25:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:25:12 INFO - 'download_minidump_stackwalk': True, 00:25:12 INFO - 'download_symbols': 'ondemand', 00:25:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:25:12 INFO - 'tooltool.py': '/tools/tooltool.py', 00:25:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:25:12 INFO - '/tools/misc-python/virtualenv.py')}, 00:25:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:25:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:25:12 INFO - 'installer_path': 'installer.exe', 00:25:12 INFO - 'log_level': 'info', 00:25:12 INFO - 'log_name': 'talos', 00:25:12 INFO - 'log_to_console': True, 00:25:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:25:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:25:12 INFO - 'opt_config_files': (), 00:25:12 INFO - 'pip_index': False, 00:25:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:25:12 INFO - 'cmd': ('bash', 00:25:12 INFO - '-c', 00:25:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:25:12 INFO - 'enabled': True, 00:25:12 INFO - 'halt_on_failure': False, 00:25:12 INFO - 'name': 'check_screen_resolution'},), 00:25:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:25:12 INFO - 'cmd': ('bash', 00:25:12 INFO - '-c', 00:25:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:25:12 INFO - 'enabled': True, 00:25:12 INFO - 'halt_on_failure': False, 00:25:12 INFO - 'name': 'check_screen_resolution'},), 00:25:12 INFO - 'run_cmd_checks_enabled': True, 00:25:12 INFO - 'sps_profile': False, 00:25:12 INFO - 'sps_profile_interval': 0, 00:25:12 INFO - 'suite': 'dromaeojs', 00:25:12 INFO - 'system_bits': '32', 00:25:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:25:12 INFO - 'title': 't-yosemite-r7-0192', 00:25:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:25:12 INFO - 'use_talos_json': True, 00:25:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:25:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:25:12 INFO - 'work_dir': 'build'} 00:25:12 INFO - ##### 00:25:12 INFO - ##### Running clobber step. 00:25:12 INFO - ##### 00:25:12 INFO - Running pre-action listener: _resource_record_pre_action 00:25:12 INFO - Running main action method: clobber 00:25:12 INFO - rmtree: /builds/slave/test/build 00:25:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:25:14 INFO - Running post-action listener: _resource_record_post_action 00:25:14 INFO - ##### 00:25:14 INFO - ##### Running read-buildbot-config step. 00:25:14 INFO - ##### 00:25:14 INFO - Running pre-action listener: _resource_record_pre_action 00:25:14 INFO - Running main action method: read_buildbot_config 00:25:14 INFO - Using buildbot properties: 00:25:14 INFO - { 00:25:14 INFO - "project": "", 00:25:14 INFO - "product": "firefox", 00:25:14 INFO - "script_repo_revision": "production", 00:25:14 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 00:25:14 INFO - "repository": "", 00:25:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 00:25:14 INFO - "buildid": "20160309233121", 00:25:14 INFO - "pgo_build": "False", 00:25:14 INFO - "basedir": "/builds/slave/test", 00:25:14 INFO - "buildnumber": 483, 00:25:14 INFO - "slavename": "t-yosemite-r7-0192", 00:25:14 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 00:25:14 INFO - "platform": "yosemite_r7", 00:25:14 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:25:14 INFO - "branch": "fx-team", 00:25:14 INFO - "repo_path": "integration/fx-team", 00:25:14 INFO - "revision": "f7abc73ebddbff1d47753051faafda94c61916c3", 00:25:14 INFO - "stage_platform": "macosx64", 00:25:14 INFO - "builduid": "20b810b7e01d454cb295a8231df089ab", 00:25:14 INFO - "slavebuilddir": "test" 00:25:14 INFO - } 00:25:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 00:25:14 INFO - Running post-action listener: _resource_record_post_action 00:25:14 INFO - ##### 00:25:14 INFO - ##### Running download-and-extract step. 00:25:14 INFO - ##### 00:25:14 INFO - Running pre-action listener: _resource_record_pre_action 00:25:14 INFO - Running main action method: download_and_extract 00:25:14 INFO - mkdir: /builds/slave/test/build/tests 00:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:25:14 INFO - https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 00:25:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 00:25:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 00:25:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 00:25:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 00:25:15 INFO - Downloaded 1199 bytes. 00:25:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 00:25:15 INFO - Using the following test package requirements: 00:25:15 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 00:25:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:25:15 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 00:25:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:25:15 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 00:25:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:25:15 INFO - u'jsshell-mac.zip'], 00:25:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:25:15 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 00:25:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 00:25:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:25:15 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 00:25:15 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:25:15 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 00:25:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:25:15 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 00:25:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:25:15 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 00:25:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:25:15 INFO - https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:25:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 00:25:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 00:25:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 00:25:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:25:16 INFO - Downloaded 17866194 bytes. 00:25:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:25:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 00:25:19 INFO - Return code: 0 00:25:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:25: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')]} 00:25:19 INFO - https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:25:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 00:25:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 00:25:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 00:25:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:25:20 INFO - Downloaded 17866194 bytes. 00:25:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:25:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 00:25:24 INFO - Return code: 0 00:25: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')]} 00:25:24 INFO - https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 00:25:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 00:25:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 00:25:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 00:25:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:25:26 INFO - Downloaded 10845161 bytes. 00:25:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:25:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 00:25:26 INFO - Return code: 0 00:25:26 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')]} 00:25:26 INFO - https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 00:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 00:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 00:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 00:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 00:25:33 INFO - Downloaded 110927550 bytes. 00:25:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 00:25:33 INFO - mkdir: /builds/slave/test/properties 00:25:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:25:33 INFO - Writing to file /builds/slave/test/properties/build_url 00:25:33 INFO - Contents: 00:25:33 INFO - build_url:https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 00:25:34 INFO - Running post-action listener: _resource_record_post_action 00:25:34 INFO - Running post-action listener: set_extra_try_arguments 00:25:34 INFO - ##### 00:25:34 INFO - ##### Running populate-webroot step. 00:25:34 INFO - ##### 00:25:34 INFO - Running pre-action listener: _resource_record_pre_action 00:25:34 INFO - Running main action method: populate_webroot 00:25:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:25:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:25:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:25:34 INFO - '--tppagecycles', 00:25:34 INFO - '7'], 00:25:34 INFO - 'tests': ['tsvgm']}}, 00:25:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:25:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:25:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:25:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 00:25:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:25:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:25:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:25:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:25:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:25:34 INFO - 'talos_options': ['--e10s'], 00:25:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:25:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:25:34 INFO - 'tests': ['damp', 'tps']}, 00:25:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:25:34 INFO - 'talos_options': ['--e10s'], 00:25:34 INFO - 'tests': ['damp', 'tps']}, 00:25:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:25:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:25:34 INFO - 'other': {'tests': ['a11yr', 00:25:34 INFO - 'ts_paint', 00:25:34 INFO - 'tpaint', 00:25:34 INFO - 'sessionrestore', 00:25:34 INFO - 'sessionrestore_no_auto_restore', 00:25:34 INFO - 'tabpaint']}, 00:25:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:25:34 INFO - 'tests': ['a11yr', 00:25:34 INFO - 'ts_paint', 00:25:34 INFO - 'tpaint', 00:25:34 INFO - 'sessionrestore', 00:25:34 INFO - 'sessionrestore_no_auto_restore', 00:25:34 INFO - 'tabpaint']}, 00:25:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:25:34 INFO - 'tests': ['a11yr', 00:25:34 INFO - 'ts_paint', 00:25:34 INFO - 'tpaint', 00:25:34 INFO - 'sessionrestore', 00:25:34 INFO - 'sessionrestore_no_auto_restore', 00:25:34 INFO - 'tabpaint']}, 00:25:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:25:34 INFO - 'tests': ['a11yr', 00:25:34 INFO - 'ts_paint', 00:25:34 INFO - 'tpaint', 00:25:34 INFO - 'sessionrestore', 00:25:34 INFO - 'sessionrestore_no_auto_restore', 00:25:34 INFO - 'tabpaint']}, 00:25:34 INFO - 'other_l64': {'tests': ['a11yr', 00:25:34 INFO - 'ts_paint', 00:25:34 INFO - 'tpaint', 00:25:34 INFO - 'sessionrestore', 00:25:34 INFO - 'sessionrestore_no_auto_restore', 00:25:34 INFO - 'tabpaint']}, 00:25:34 INFO - 'other_nol64': {'tests': ['a11yr', 00:25:34 INFO - 'ts_paint', 00:25:34 INFO - 'tpaint', 00:25:34 INFO - 'sessionrestore', 00:25:34 INFO - 'sessionrestore_no_auto_restore', 00:25:34 INFO - 'tabpaint']}, 00:25:34 INFO - 'svgr': {'tests': ['tsvgx', 00:25:34 INFO - 'tsvgr_opacity', 00:25:34 INFO - 'tart', 00:25:34 INFO - 'tscrollx', 00:25:34 INFO - 'cart']}, 00:25:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:25:34 INFO - 'tests': ['tsvgx', 00:25:34 INFO - 'tsvgr_opacity', 00:25:34 INFO - 'tart', 00:25:34 INFO - 'tscrollx', 00:25:34 INFO - 'cart']}, 00:25:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:25:34 INFO - 'tests': ['tp5o']}, 00:25:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:25:34 INFO - 'talos_options': ['--e10s'], 00:25:34 INFO - 'tests': ['tp5o']}, 00:25:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:25:34 INFO - 'talos_options': ['--xperf_path', 00:25:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:25:34 INFO - 'tests': ['tp5n']}, 00:25:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:25:34 INFO - 'talos_options': ['--e10s', 00:25:34 INFO - '--xperf_path', 00:25:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:25:34 INFO - 'tests': ['tp5n']}}, 00:25:34 INFO - 'talos.zip': {'path': '', 00:25:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:25:34 INFO - Running post-action listener: _resource_record_post_action 00:25:34 INFO - ##### 00:25:34 INFO - ##### Running create-virtualenv step. 00:25:34 INFO - ##### 00:25:34 INFO - Running pre-action listener: _resource_record_pre_action 00:25:34 INFO - Running main action method: create_virtualenv 00:25:34 INFO - Creating virtualenv /builds/slave/test/build/venv 00:25:34 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 00:25:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:25:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:25:34 INFO - Using real prefix '/tools/python27' 00:25:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:25:34 INFO - Installing distribute.............................................................................................................................................................................................done. 00:25:37 INFO - Installing pip.................done. 00:25:37 INFO - Return code: 0 00:25:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:25:37 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')]} 00:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:37 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')]} 00:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:37 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 0x103e18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadac73600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cbcd30>, '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 0x103ae0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cb3b20>, '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.daiMr2COte/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.jZfynUqwKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 00:25:37 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 00:25:37 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 00:25:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daiMr2COte/Render', 00:25:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:37 INFO - 'HOME': '/Users/cltbld', 00:25:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:37 INFO - 'LOGNAME': 'cltbld', 00:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:37 INFO - 'MOZ_NO_REMOTE': '1', 00:25:37 INFO - 'NO_EM_RESTART': '1', 00:25:37 INFO - 'PAGER': '/bin/cat', 00:25:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:37 INFO - 'PWD': '/builds/slave/test', 00:25:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:37 INFO - 'SHELL': '/bin/bash', 00:25:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jZfynUqwKg/Listeners', 00:25:37 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 00:25:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:37 INFO - 'USER': 'cltbld', 00:25:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:37 INFO - 'XPC_FLAGS': '0x0', 00:25:37 INFO - 'XPC_SERVICE_NAME': '0', 00:25:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:38 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 00:25:38 INFO - Cleaning up... 00:25:38 INFO - Return code: 0 00:25:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:25: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')]} 00:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25: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')]} 00:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103e18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadac73600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cbcd30>, '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 0x103ae0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cb3b20>, '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.daiMr2COte/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.jZfynUqwKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 00:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daiMr2COte/Render', 00:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:38 INFO - 'HOME': '/Users/cltbld', 00:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:38 INFO - 'LOGNAME': 'cltbld', 00:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:38 INFO - 'MOZ_NO_REMOTE': '1', 00:25:38 INFO - 'NO_EM_RESTART': '1', 00:25:38 INFO - 'PAGER': '/bin/cat', 00:25:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:38 INFO - 'PWD': '/builds/slave/test', 00:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:38 INFO - 'SHELL': '/bin/bash', 00:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jZfynUqwKg/Listeners', 00:25:38 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 00:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:38 INFO - 'USER': 'cltbld', 00:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:38 INFO - 'XPC_FLAGS': '0x0', 00:25:38 INFO - 'XPC_SERVICE_NAME': '0', 00:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:38 INFO - Downloading/unpacking psutil>=0.7.1 00:25:38 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 00:25:38 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 00:25:38 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 00:25:38 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 00:25:38 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 00:25:38 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 00:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:25:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:25:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:25:41 INFO - Installing collected packages: psutil 00:25:41 INFO - Running setup.py install for psutil 00:25:41 INFO - building 'psutil._psutil_osx' extension 00:25:41 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 00:25:41 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 00:25:41 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 00:25:42 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 00:25:42 INFO - building 'psutil._psutil_posix' extension 00:25:42 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 00:25:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:25:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:25:42 INFO - ^ 00:25:42 INFO - 1 warning generated. 00:25:42 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 00:25:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:25:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:25:42 INFO - Successfully installed psutil 00:25:42 INFO - Cleaning up... 00:25:42 INFO - Return code: 0 00:25:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:25:42 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')]} 00:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:42 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')]} 00:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:42 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 0x103e18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadac73600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cbcd30>, '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 0x103ae0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cb3b20>, '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.daiMr2COte/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.jZfynUqwKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 00:25:42 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 00:25:42 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 00:25:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daiMr2COte/Render', 00:25:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:42 INFO - 'HOME': '/Users/cltbld', 00:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:42 INFO - 'LOGNAME': 'cltbld', 00:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:42 INFO - 'MOZ_NO_REMOTE': '1', 00:25:42 INFO - 'NO_EM_RESTART': '1', 00:25:42 INFO - 'PAGER': '/bin/cat', 00:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:42 INFO - 'PWD': '/builds/slave/test', 00:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:42 INFO - 'SHELL': '/bin/bash', 00:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jZfynUqwKg/Listeners', 00:25:42 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 00:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:42 INFO - 'USER': 'cltbld', 00:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:42 INFO - 'XPC_FLAGS': '0x0', 00:25:42 INFO - 'XPC_SERVICE_NAME': '0', 00:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:25:45 INFO - Installing collected packages: mozsystemmonitor 00:25:45 INFO - Running setup.py install for mozsystemmonitor 00:25:45 INFO - Successfully installed mozsystemmonitor 00:25:45 INFO - Cleaning up... 00:25:45 INFO - Return code: 0 00:25:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103e18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadac73600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cbcd30>, '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 0x103ae0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cb3b20>, '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.daiMr2COte/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.jZfynUqwKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 00:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:25:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daiMr2COte/Render', 00:25:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:45 INFO - 'HOME': '/Users/cltbld', 00:25:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:45 INFO - 'LOGNAME': 'cltbld', 00:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:45 INFO - 'MOZ_NO_REMOTE': '1', 00:25:45 INFO - 'NO_EM_RESTART': '1', 00:25:45 INFO - 'PAGER': '/bin/cat', 00:25:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:45 INFO - 'PWD': '/builds/slave/test', 00:25:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:45 INFO - 'SHELL': '/bin/bash', 00:25:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jZfynUqwKg/Listeners', 00:25:45 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 00:25:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:45 INFO - 'USER': 'cltbld', 00:25:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:45 INFO - 'XPC_FLAGS': '0x0', 00:25:45 INFO - 'XPC_SERVICE_NAME': '0', 00:25:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:45 INFO - Downloading/unpacking blobuploader==1.2.4 00:25:45 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 00:25:45 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 00:25:45 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 00:25:45 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 00:25:45 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 00:25:45 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 00:25:47 INFO - Downloading blobuploader-1.2.4.tar.gz 00:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:25:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:25: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 00:25: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 00:25: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 00:25: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 00:25: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 00:25: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 00:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:25:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:25:49 INFO - Downloading docopt-0.6.1.tar.gz 00:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:25:49 INFO - Installing collected packages: blobuploader, requests, docopt 00:25:49 INFO - Running setup.py install for blobuploader 00:25:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:25:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:25:49 INFO - Running setup.py install for requests 00:25:49 INFO - Running setup.py install for docopt 00:25:49 INFO - Successfully installed blobuploader requests docopt 00:25:49 INFO - Cleaning up... 00:25:50 INFO - Return code: 0 00:25:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:25:50 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')]} 00:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:50 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')]} 00:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:50 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 0x103e18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadac73600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cbcd30>, '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 0x103ae0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cb3b20>, '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.daiMr2COte/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.jZfynUqwKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 00:25:50 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 00:25:50 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 00:25:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daiMr2COte/Render', 00:25:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:50 INFO - 'HOME': '/Users/cltbld', 00:25:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:50 INFO - 'LOGNAME': 'cltbld', 00:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:50 INFO - 'MOZ_NO_REMOTE': '1', 00:25:50 INFO - 'NO_EM_RESTART': '1', 00:25:50 INFO - 'PAGER': '/bin/cat', 00:25:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:50 INFO - 'PWD': '/builds/slave/test', 00:25:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:50 INFO - 'SHELL': '/bin/bash', 00:25:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jZfynUqwKg/Listeners', 00:25:50 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 00:25:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:50 INFO - 'USER': 'cltbld', 00:25:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:50 INFO - 'XPC_FLAGS': '0x0', 00:25:50 INFO - 'XPC_SERVICE_NAME': '0', 00:25:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:25:50 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-39rxns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:25:50 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-j9mWfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:25:50 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ElVY5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:25:50 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-iWcsNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:25:50 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-lvrdbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:25:50 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-1lcD0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:25:50 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-r6SgVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:25:50 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-vBiTxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:25:51 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-qfCZbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:25:51 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ZPCJqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:25:51 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-2tyM8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:25:51 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-xxsNWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:25:51 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-OvOlaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:25:51 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-zDnI1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:25:51 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-zzISOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:25:51 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-PJ2kjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:25:51 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-C3TYEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:25:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:25:52 INFO - Running setup.py install for manifestparser 00:25:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Running setup.py install for mozcrash 00:25:52 INFO - Running setup.py install for mozdebug 00:25:52 INFO - Running setup.py install for mozdevice 00:25:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Running setup.py install for mozfile 00:25:52 INFO - Running setup.py install for mozhttpd 00:25:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:25:52 INFO - Running setup.py install for mozinfo 00:25:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Running setup.py install for mozInstall 00:25:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Running setup.py install for mozleak 00:25:53 INFO - Running setup.py install for mozlog 00:25:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Running setup.py install for moznetwork 00:25:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Running setup.py install for mozprocess 00:25:53 INFO - Running setup.py install for mozprofile 00:25:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:25:53 INFO - Running setup.py install for mozrunner 00:25:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:25:54 INFO - Running setup.py install for mozscreenshot 00:25:54 INFO - Running setup.py install for moztest 00:25:54 INFO - Running setup.py install for mozversion 00:25:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:25:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:25:54 INFO - Cleaning up... 00:25:54 INFO - Return code: 0 00:25:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:54 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 0x103e18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadac73600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cbcd30>, '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 0x103ae0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cb3b20>, '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.daiMr2COte/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.jZfynUqwKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 00:25:54 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 00:25:54 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 00:25:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daiMr2COte/Render', 00:25:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:54 INFO - 'HOME': '/Users/cltbld', 00:25:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:54 INFO - 'LOGNAME': 'cltbld', 00:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:54 INFO - 'MOZ_NO_REMOTE': '1', 00:25:54 INFO - 'NO_EM_RESTART': '1', 00:25:54 INFO - 'PAGER': '/bin/cat', 00:25:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:54 INFO - 'PWD': '/builds/slave/test', 00:25:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:54 INFO - 'SHELL': '/bin/bash', 00:25:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jZfynUqwKg/Listeners', 00:25:54 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 00:25:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:54 INFO - 'USER': 'cltbld', 00:25:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:54 INFO - 'XPC_FLAGS': '0x0', 00:25:54 INFO - 'XPC_SERVICE_NAME': '0', 00:25:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:25:54 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-e0SoyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:25:54 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)) 00:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:25:54 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-uWOpBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:25:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:25:55 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-HHwjkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:25:55 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-1JG7Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:25:55 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ot5y_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:25:55 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-u5xw4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:25:55 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-M9vHmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:25:55 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-R4HVF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:25:55 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-g0r1DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:25:55 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-miG75Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:25:55 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)) 00:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:25:55 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-xoZ9iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:25:56 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)) 00:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:25:56 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-KFZqp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:25:56 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)) 00:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:25:56 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-TaoXSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:25:56 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)) 00:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:25:56 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-iKu3vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:25:56 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)) 00:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:25:56 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-6F00DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:25:56 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)) 00:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:25:56 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-HNqOxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:25:56 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)) 00:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:25:56 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-IyJBlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:25:56 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)) 00:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:25:56 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)) 00:25:56 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)) 00:25:56 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)) 00:25:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:25:56 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 00:25:56 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 00:25:56 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 00:25:56 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 00:25:56 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 00:25:56 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 00:25:58 INFO - Downloading blessings-1.6.tar.gz 00:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:25:59 INFO - Installing collected packages: blessings 00:25:59 INFO - Running setup.py install for blessings 00:25:59 INFO - Successfully installed blessings 00:25:59 INFO - Cleaning up... 00:25:59 INFO - Return code: 0 00:25:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:25:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:25:59 INFO - Reading from file tmpfile_stdout 00:25:59 INFO - Current package versions: 00:25:59 INFO - blessings == 1.6 00:25:59 INFO - blobuploader == 1.2.4 00:25:59 INFO - docopt == 0.6.1 00:25:59 INFO - manifestparser == 1.1 00:25:59 INFO - mozInstall == 1.12 00:25:59 INFO - mozcrash == 0.17 00:25:59 INFO - mozdebug == 0.1 00:25:59 INFO - mozdevice == 0.48 00:25:59 INFO - mozfile == 1.2 00:25:59 INFO - mozhttpd == 0.7 00:25:59 INFO - mozinfo == 0.9 00:25:59 INFO - mozleak == 0.1 00:25:59 INFO - mozlog == 3.1 00:25:59 INFO - moznetwork == 0.27 00:25:59 INFO - mozprocess == 0.22 00:25:59 INFO - mozprofile == 0.28 00:25:59 INFO - mozrunner == 6.11 00:25:59 INFO - mozscreenshot == 0.1 00:25:59 INFO - mozsystemmonitor == 0.0 00:25:59 INFO - moztest == 0.7 00:25:59 INFO - mozversion == 1.4 00:25:59 INFO - psutil == 3.1.1 00:25:59 INFO - requests == 1.2.3 00:25:59 INFO - wsgiref == 0.1.2 00:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:25:59 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')]} 00:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:59 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')]} 00:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:59 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 0x103e18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadac73600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cbcd30>, '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 0x103ae0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cb3b20>, '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.daiMr2COte/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.jZfynUqwKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 00:25:59 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 00:25:59 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 00:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daiMr2COte/Render', 00:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:59 INFO - 'HOME': '/Users/cltbld', 00:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:59 INFO - 'LOGNAME': 'cltbld', 00:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:59 INFO - 'MOZ_NO_REMOTE': '1', 00:25:59 INFO - 'NO_EM_RESTART': '1', 00:25:59 INFO - 'PAGER': '/bin/cat', 00:25:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:59 INFO - 'PWD': '/builds/slave/test', 00:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:59 INFO - 'SHELL': '/bin/bash', 00:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jZfynUqwKg/Listeners', 00:25:59 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 00:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:59 INFO - 'USER': 'cltbld', 00:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:59 INFO - 'XPC_FLAGS': '0x0', 00:25:59 INFO - 'XPC_SERVICE_NAME': '0', 00:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 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)) 00:25:59 INFO - Cleaning up... 00:25:59 INFO - Return code: 0 00:25:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:25:59 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')]} 00:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:59 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')]} 00:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:25:59 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 0x103e18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadac73600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cbcd30>, '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 0x103ae0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cb3b20>, '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.daiMr2COte/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.jZfynUqwKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 00:25:59 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 00:25:59 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 00:25:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daiMr2COte/Render', 00:25:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:25:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:25:59 INFO - 'HOME': '/Users/cltbld', 00:25:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:25:59 INFO - 'LOGNAME': 'cltbld', 00:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:25:59 INFO - 'MOZ_NO_REMOTE': '1', 00:25:59 INFO - 'NO_EM_RESTART': '1', 00:25:59 INFO - 'PAGER': '/bin/cat', 00:25:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:25:59 INFO - 'PWD': '/builds/slave/test', 00:25:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:25:59 INFO - 'SHELL': '/bin/bash', 00:25:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jZfynUqwKg/Listeners', 00:25:59 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 00:25:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:25:59 INFO - 'USER': 'cltbld', 00:25:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:25:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:25:59 INFO - 'XPC_FLAGS': '0x0', 00:25:59 INFO - 'XPC_SERVICE_NAME': '0', 00:25:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:00 INFO - Downloading/unpacking jsonschema 00:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:26:02 INFO - Downloading/unpacking functools32 (from jsonschema) 00:26:02 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 00:26:02 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 00:26:02 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 00:26:02 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 00:26:02 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 00:26:02 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 00:26:02 INFO - Downloading functools32-3.2.3-2.tar.gz 00:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:26:02 INFO - warning: no files found matching '*.txt' 00:26:02 INFO - no previously-included directories found matching 'build' 00:26:02 INFO - no previously-included directories found matching 'dist' 00:26:02 INFO - no previously-included directories found matching '.git*' 00:26:02 INFO - Installing collected packages: jsonschema, functools32 00:26:03 INFO - Running setup.py install for functools32 00:26:03 INFO - warning: no files found matching '*.txt' 00:26:03 INFO - no previously-included directories found matching 'build' 00:26:03 INFO - no previously-included directories found matching 'dist' 00:26:03 INFO - no previously-included directories found matching '.git*' 00:26:03 INFO - Successfully installed jsonschema functools32 00:26:03 INFO - Cleaning up... 00:26:03 INFO - Return code: 0 00:26:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:26:03 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')]} 00:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:03 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')]} 00:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:03 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 0x103e18a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e204c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffadac73600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cbcd30>, '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 0x103ae0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cb3b20>, '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.daiMr2COte/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.jZfynUqwKg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 00:26:03 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 00:26:03 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 00:26:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daiMr2COte/Render', 00:26:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:26:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:26:03 INFO - 'HOME': '/Users/cltbld', 00:26:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:26:03 INFO - 'LOGNAME': 'cltbld', 00:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:03 INFO - 'MOZ_NO_REMOTE': '1', 00:26:03 INFO - 'NO_EM_RESTART': '1', 00:26:03 INFO - 'PAGER': '/bin/cat', 00:26:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:03 INFO - 'PWD': '/builds/slave/test', 00:26:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:26:03 INFO - 'SHELL': '/bin/bash', 00:26:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jZfynUqwKg/Listeners', 00:26:03 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 00:26:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:26:03 INFO - 'USER': 'cltbld', 00:26:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:26:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:03 INFO - 'XPC_FLAGS': '0x0', 00:26:03 INFO - 'XPC_SERVICE_NAME': '0', 00:26:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:03 INFO - Downloading/unpacking flake8 00:26:03 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 00:26:03 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 00:26:03 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 00:26:03 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 00:26:03 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 00:26:03 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 00:26:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:26:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:26:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:26:06 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 00:26:06 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 00:26:06 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 00:26:06 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 00:26:06 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 00:26:06 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 00:26:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:26:06 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 00:26:06 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 00:26:06 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 00:26:06 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 00:26:06 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 00:26:06 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 00:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:26:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:26:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:26:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:26:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:26:07 INFO - no previously-included directories found matching 'docs/_build' 00:26:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:26:07 INFO - Running setup.py install for pep8 00:26:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:26:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:26:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:26:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:26:07 INFO - no previously-included directories found matching 'docs/_build' 00:26:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:26:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:26:07 INFO - Cleaning up... 00:26:07 INFO - Return code: 0 00:26:07 INFO - Running post-action listener: _resource_record_post_action 00:26:07 INFO - Running post-action listener: _start_resource_monitoring 00:26:07 INFO - Starting resource monitoring. 00:26:07 INFO - ##### 00:26:07 INFO - ##### Running install step. 00:26:07 INFO - ##### 00:26:07 INFO - Running pre-action listener: _resource_record_pre_action 00:26:07 INFO - Running main action method: install 00:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:26:07 INFO - Reading from file tmpfile_stdout 00:26:07 INFO - Detecting whether we're running mozinstall >=1.0... 00:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:26:07 INFO - Reading from file tmpfile_stdout 00:26:07 INFO - Output received: 00:26:07 INFO - Usage: mozinstall [options] installer 00:26:07 INFO - Options: 00:26:07 INFO - -h, --help show this help message and exit 00:26:07 INFO - -d DEST, --destination=DEST 00:26:07 INFO - Directory to install application into. [default: 00:26:07 INFO - "/builds/slave/test"] 00:26:07 INFO - --app=APP Application being installed. [default: firefox] 00:26:07 INFO - mkdir: /builds/slave/test/build/application 00:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:26:41 INFO - Reading from file tmpfile_stdout 00:26:41 INFO - Output received: 00:26:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:26:41 INFO - Running post-action listener: _resource_record_post_action 00:26:41 INFO - ##### 00:26:41 INFO - ##### Running run-tests step. 00:26:41 INFO - ##### 00:26:41 INFO - Running pre-action listener: _resource_record_pre_action 00:26:41 INFO - Running main action method: run_tests 00:26:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:26:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:26:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:26:41 INFO - 2016-03-10 00:26:41.398 screenresolution[1640:7338] starting screenresolution argv=screenresolution get 00:26:41 INFO - 2016-03-10 00:26:41.401 screenresolution[1640:7338] Display 0: 1600x1200x32@60 00:26:41 INFO - 2016-03-10 00:26:41.407 screenresolution[1641:7340] starting screenresolution argv=screenresolution list 00:26:41 INFO - Available Modes on Display 0 00:26:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:26:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:26:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:26:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:26:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:26:41 INFO - Intel Iris: 00:26:41 INFO - Chipset Model: Intel Iris 00:26:41 INFO - Type: GPU 00:26:41 INFO - Bus: Built-In 00:26:41 INFO - VRAM (Dynamic, Max): 1536 MB 00:26:41 INFO - Vendor: Intel (0x8086) 00:26:41 INFO - Device ID: 0x0a2e 00:26:41 INFO - Revision ID: 0x0009 00:26:41 INFO - Displays: 00:26:41 INFO - Display: 00:26:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:26:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:26:41 INFO - Display Serial Number: 1600x1200 60 00:26:41 INFO - Main Display: Yes 00:26:41 INFO - Mirror: Off 00:26:41 INFO - Online: Yes 00:26:41 INFO - Rotation: Supported 00:26:41 INFO - Return code: 0 00:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:26:41 INFO - Python 2.7.3 00:26:41 INFO - Return code: 0 00:26:41 INFO - grabbing minidump binary from tooltool 00:26:41 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')]} 00:26:41 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 0x103cbcd30>, '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 0x103ae0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103cb3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:26:41 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 00:26:41 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 00:26:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:26:41 INFO - Return code: 0 00:26:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:26:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:26:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:26:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:26:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:26:42 INFO - Return code: 0 00:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0192 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.daiMr2COte/Render', 00:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:26:42 INFO - 'HOME': '/Users/cltbld', 00:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:26:42 INFO - 'LOGNAME': 'cltbld', 00:26:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:26:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:42 INFO - 'MOZ_NO_REMOTE': '1', 00:26:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:26:42 INFO - 'NO_EM_RESTART': '1', 00:26:42 INFO - 'PAGER': '/bin/cat', 00:26:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:42 INFO - 'PWD': '/builds/slave/test', 00:26:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:26:42 INFO - 'SHELL': '/bin/bash', 00:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jZfynUqwKg/Listeners', 00:26:42 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 00:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:26:42 INFO - 'USER': 'cltbld', 00:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:42 INFO - 'XPC_FLAGS': '0x0', 00:26:42 INFO - 'XPC_SERVICE_NAME': '0', 00:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:26:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:26:43 INFO - mozversion application_buildid: 20160309233121 00:26:43 INFO - mozversion application_changeset: f7abc73ebddbff1d47753051faafda94c61916c3 00:26:43 INFO - mozversion application_display_name: Nightly 00:26:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:26:43 INFO - mozversion application_name: Firefox 00:26:43 INFO - mozversion application_remotingname: firefox 00:26:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:26:43 INFO - mozversion application_vendor: Mozilla 00:26:43 INFO - mozversion application_version: 48.0a1 00:26:43 INFO - mozversion platform_buildid: 20160309233121 00:26:43 INFO - mozversion platform_changeset: f7abc73ebddbff1d47753051faafda94c61916c3 00:26:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:26:43 INFO - mozversion platform_version: 48.0a1 00:26:43 INFO - using testdate: 1457598403 00:26:43 INFO - actual date: 1457598403 00:26:43 INFO - starting webserver on 'localhost:49271' 00:26:43 INFO - SUITE-START | Running 2 tests 00:26:43 INFO - TEST-START | dromaeo_css 00:26:43 INFO - operating with platform_type : mac_ 00:26:43 INFO - Initialising browser for dromaeo_css test... 00:26:43 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpi1WlMC/profile http://localhost:49271/getInfo.html) 00:26:45 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 00:26:45 INFO - PROCESS | 1659 | colorDepth:24 00:26:45 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 00:26:45 INFO - PROCESS | 1659 | __metrics 00:26:45 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:26:45 ERROR - PROCESS | 1659 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:26:46 INFO - TEST-INFO | 1659: exit 0 00:26:46 INFO - Browser initialized. 00:26:46 INFO - Running cycle 1/1 for dromaeo_css test... 00:26:46 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpi1WlMC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:26:57 INFO - PROCESS | 1662 | RSS: Main: 242921472 00:26:57 INFO - PROCESS | 1662 | 00:27:48 INFO - PROCESS | 1662 | 1457598468936 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] 00:29:58 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 00:30:00 INFO - PROCESS | 1662 | RSS: Main: 328228864 00:30:00 INFO - PROCESS | 1662 | 00:33:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 00:33:02 INFO - PROCESS | 1662 | RSS: Main: 377139200 00:33:02 INFO - PROCESS | 1662 | 00:36:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 00:36:05 INFO - PROCESS | 1662 | RSS: Main: 376786944 00:36:05 INFO - PROCESS | 1662 | 00:39:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 00:39:08 INFO - PROCESS | 1662 | RSS: Main: 333500416 00:39:08 INFO - PROCESS | 1662 | 00:42:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 00:42:12 INFO - PROCESS | 1662 | RSS: Main: 334712832 00:42:12 INFO - PROCESS | 1662 | 00:45:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 00:45:15 INFO - PROCESS | 1662 | RSS: Main: 401715200 00:45:15 INFO - PROCESS | 1662 | 00:45:15 INFO - PROCESS | 1662 | __start_tp_report 00:45:15 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 00:45:15 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 00:45:15 INFO - PROCESS | 1662 | |i|pagename|runs| 00:45:15 INFO - PROCESS | 1662 | |0;dojo.html;2638.6437830892837;3393.0838673558137;3399.62026581393;3454.1191996041007;3495.2659941412303;5495.890082198353;5544.0575102232615;5614.0736778431565;5649;5658.292713410819;5532.114861622142;5630.605857589971;5631.943680563193;5633.267675202228;5635.718214089299;5075.365579302587;5122.257272695457;5122.564582010515;5176.223566465042;5204.959008198357;4342;5132.8973420531565;5181.3264275644115;5207;5234.555062819665;5167.534921857032;5176.50823171798;5194.584433245332;5223.320968274119;5245.082110630643;5180.792768289264;5215.713135777531;5234.18870075139;5236.083685355047;5259.342582177228;4125.50493940726;5064.594832413435;5097.0315640028275;5136.897262054776;5185.922211166836;5519.420460851593;5528.06022976091;5550.69471179085;5573.27547418833;5614.438556144394;6152.3847615238565;6180.196574445338;6188.597741146856;6204.100405441186;6205.844853878644;6040.911097991169;6084;6154.857080275961;6187.319394866561;6204.7828326008375;5655.462731040545;5680.6591604503865;5685.346185188715;5688.345840228427;5727.312722473288;5537.252470916455;5942.405759424109;6255.812325630239;6309.08518264849;6367.745290188341;5915.792947246911;6012.549058820518;6045.607035542764;6108.129596501707;6122.703114648715;6136.386361363828;6152.907706384408;6153.600015998945;6163.537734669918;6164.537659675452;6060.606060606135;6065.8180254592435;6086.756529738761;6089.725962331706;6104.847378815565;6045.063015232646;6131.294901086432;6156.476699480594;6176.3514830943;6187.938120618826;4833.637477189154;4849.224124140121;4864.586510146677;4880.853574392774;4898.779554920037;4277.465316835395;4351.608355248043;4386.978065109654;4392.05570802279;4423.447069116361;5537.335519737658;5552.3892371839065;5605.971970140124;5612.775488980476;5759.51044161251;6227.626342419469;6237.251529816451;6256.624602523863;6262.091996660459;6274.592151510228;5643.943560564424;5652.851231879038;5662.518685911744;5673.8297851064535;5725.914111288334;5223.2948551945;5289.127293996447;5315.123004704181;5325.227841962894;5327.920081198785;6246.063090536456;6282.371762823681;6290.119383286435;6294.842628934313;6305.96847015762;5965.791197308074;6089.817305480666;6090.786822461193;6094.786682466092;6127.417895300117;6223.066540019034;6239.376062393906;6287.371262873676;6304.5586808922935;6385.201849768779;6101.6644084574;6121.0206366981065;6124.724387402489;6131.325554188947;6132.2947860996555;6149.2313460817395;6166.383903917073;6203.2245969253845;6219.533534984804;6227.626342419469;5828.184054232326;5947.2393490801005;5971.462568368867;6054.727537260922;6104.816855494342;5921.940780592139;5994.700264986646;6010.368911264429;6010.909836352545;6012;5697.401772813795;5867.266591676041;5885.234919460443;5912.113183022581;5916.083007133901;5824.912626310694;5981.252343457068;6030.698465076816;6043.516518678583;6085.908711369245;5824.068149096124;5846.239988801429;5846.649201047951;5852.502537284378;5854.063349864001 00:45:15 INFO - PROCESS | 1662 | |1;ext.html;506.6858547700426;527.7361319340328;588.393954227146;640.6156306216271;643.5173619785161;25003.74996250037;31001.224969375777;31044;38908.02729931753;39271.60728392715;42541.78729106358;42854.57145428545;42966.35550466745;43042.92392690184;43077.353839692354;9601.471919044432;9815.803683926317;9875.160611348045;9877.160441362494;9894.060064293917;9621.663241786538;9757.219422446222;9760.511974401286;9783.168430683401;9783.315167938246;9751.75620609487;9821.066998635153;9823.65617203398;9958.20334373252;9985.35095218812;9864.260180486457;9920.90079099207;9925.553350099262;9930.255230857678;9938.055884690943;9797.853032204523;9928.404295742279;9929.90070099297;9932.006799320083;9937.80124397508;36562.63437365619;39231.80384098061;41593.1681366374;41598.376024359655;41732.58267417348;3163.715265626082;3180.4434224010706;3209.9679003210135;3231.9958643178197;3408.16499957512;28867.576869782002;28893.29165090306;29039.803322417793;29216.269593260127;29311.120666380044;2755.2423083651956;2797.4125433658955;2799.6080548723194;2805.0743254726094;2863.298491869505;496238;496462;497994.51002745115;498532.5073374646;499993;66580.66709666517;67971.3202867965;68514;68605.31394686089;68779.74643042767;74427.25572744312;75549.62225188839;75710.24289757032;75771.86342204761;75850.62074689701;17010.82989170117;17195.914020429816;17198;17245;17262.568435789206;12888.80666789999;13008.349582520836;13011.349432528525;13045.34773261333;13074.477020919057;16960.491185264214;20890.404111095533;20963.685544716536;21322.573548529253;21358;7794.363183731367;9152.954235228914;9162.450252984841;9166.541672916328;9173;899.4827973915025;927.7912469694264;981.4356744871727;1017.8320577104843;1091.2852081886376;29645.407091858044;29802.65847651142;30078.398432031237;30089;30540.08379748611;1009.3287963504334;1089.6948854320644;1103.7406209540752;1105.5743538737484;1255.9309237991815;12298.262104273772;15097.773533397009;15172.750896548945;15227.086374817547;15358;527882;532518;532687;533954;535850;59908.400915990285;60601.39398606046;60674.39325606776;60838;60862.391376085674;1304.067591671959;1380.0960370957039;1421.7156568686305;1444.415011920174;1588.348777001447;22107.668384973917;28721.42557148887;29356.706432935396;29455.410891781616;30684.693153068183;46438.30342544932;47050.52949470598;47062.82342941454;47085.822854428916;47110.76444617755;301160;312412;313271;313856;314098;28748.281292967844;33335.33323333872;33569.47520510311;33865.66134338625;33977;41606.79196603998;42572.93567660709;42812.78593607136;42985.495507657084;43204.56795432131;34187.829060854536;35052;35179.64820351764;35726;35961.640383596874;35147.648523514436;35226;35746.28507429889;35966.920992369225;36001.27997440089;36015;36346.90959271226;36488.452673209395;36700.63299366972;36969.260614788094;31996.68003319937;32408;32617.673823261463;32678.673213267564;32752.83623581962;23277.883610581837;24030;24438.51122977495;24874.626880596443;24982.50034999326 00:45:15 INFO - PROCESS | 1662 | |2;jquery.html;311.2266018942926;358.5876242321331;362.52690239237785;367.419477225983;370.9946046214758;20510;21144.837033963126;21811.99999999998;22000.44998875029;22316.764069209956;19087.85472871625;20229.797702022974;20682.48293792656;21358.786412135913;21429.67855482169;5839.124131380285;6025.3372129065765;6026.186464827236;6056.60632058917;6079.118527813464;5529.115341545354;5803.274590676166;5811.244538210027;5811.593188476808;5949.9107513387335;4790.23356262998;5791.536677065825;5802.448767367094;5803.303603567578;5807.332156801958;5581.2186293918885;5752.7986520471795;5843.2403787507565;5845.561582881259;5881.647101173943;5567.276254086943;5585.888282234373;5587.776488940438;5591.189277554772;5605.971970140164;13710.862891371058;18885.905570472198;19671.114799834042;25650.871745641154;25670.358241044123;2040.0819631166034;2171.4462811983003;2248.7182306085538;2469.1481438903547;2565.512552615016;9862.45756483393;10011.299209055369;10195.184385249237;10286.845697314546;10305.484725763681;1762.189392879277;1803.6573051120245;1807.6384723055442;1874.6250749850085;1891.6311319292743;95278.52360738222;96927;105930;105982.47008764984;107663.46168269108;10761.031507164236;11214.271072380432;11263.831042534368;11331.886681133248;11382.886171138183;13486.730265394834;13576.93211533936;13595.116317439335;13602;13610.863891361158;8604.956975215084;8626.741197764077;8648.481091134552;8710.25962793157;8741.91258087411;8885.644574217089;8892.377533572588;8900;8975.865362019575;8983.056779038106;4486.394336764561;4503.527129651405;4519.525449827721;4542.545745425431;4603.585677288993;1851.8425933795509;1881.8870867747978;1893.1480833624923;1898.0984032584413;1915.8754680945694;874.728834061443;904.6426661468684;945.6784693204344;977.9804403911882;987.9703608891745;19756.60486790285;20057.498562536053;20149.294774682814;20384.592308153755;20953.68569471459;952.3048174832272;970.4225985538593;971.8882328532168;989.218517371283;1068.625980906692;10752.462376881125;11109.778044391154;11154.776904461865;11163.60454943132;11273.887261127284;577891;603962.7820469829;613163;619392;631807;101968.49015754873;104602.47698761457;104873.47563262288;104947.95052049535;107790.46104769426;999.0608827701936;1003.4330603209163;1019.9235057370727;1020.3724709303725;1021.4841505040056;13361.53234636783;15265.694686106437;18039;18286.817131828513;18483.815161848208;48774.44862668374;48921;49348.25977610267;50300.74849625875;50766.492335076175;70104;70117.94823077555;70945;71355;71958.28041719516;7593.696252149852;7596.734114305973;7622.16156222804;7739.3034626883855;7921.881171782313;11857.940710296394;12038.939805300917;12110.45502952387;12144.817827732768;12330.75338493243;8310.052067623648;10115.595376185165;10590.576376944837;10627;10685.038346548848;9549.52252387364;9576.138147566753;10229;10525.78948421012;10651.627193048205;8950.418222815497;10532.684019479428;10706.250562460553;10988.615398461016;11041.00630943219;7537.736179233701;7657.157712651492;7771.650275737718;7806.765797026098;7924.286814186751;10111.241656875616;10578.788424231318;10655.520501577292;10905.454727263446;10906 00:45:15 INFO - PROCESS | 1662 | |3;mootools.html;1453.941842326307;1593.5617705131092;1624.2934323569248;1918.9712154317688;2057.578196469723;8117.63470643821;8843.204111629952;9016.413933094353;9022.729318120468;9029.32280078995;8734.956325218382;8958.776030599238;8969.103089691027;8974.282057435406;9040.367174297802;2181.4001149683886;2438.756124387565;2473.4187465945533;2506.6490691303143;2513.0324824942345;2517.420993171572;2524.798016158703;2525.318164095693;2526.1916186820226;2541.1106112860534;2413.337652951871;2472.344828620417;2479.913203037894;2481.1936120760734;2485.6768620079456;2177.433867194525;2434.3427274635837;2469.2468797016904;2499.5875680512695;2501.524710305054;2386.7135943686867;2421.9152329668555;2437.622168563875;2490.1160088168804;2512.522620702079;8965.148310910517;9048.592813323416;9049.2308153807;9053.4567925924;9059.365844390895;5538.47384498472;5676.318841739017;5681.23303354046;5686.3744988051285;5691.658500489983;3586.8027258500774;3727.925441491182;3757.079515518715;3766.3408903442064;3783.921582349017;1031.3554028732042;1059.390850261103;1070.4005756776153;1071.1056268016216;1083.4582708645678;12300.892919637186;12308.507659693601;12311.876881231252;12314.753704925852;12322.445489952974;4061.2283666103344;4953.578945789576;5077.568406685399;5080.796768129308;5100.668456550312;10390.636327728493;10403.791924161626;10404.323718958394;10408.323458975143;10409.95900409953;5596.636218645856;5607.271054762855;5629.0712032514175;5640.492355687926;5644.8024319148635;4481.932771008437;4639.837605683785;4882.609391248691;4993.151164302078;5036.219385995103;3355.6644335566734;3953.3872249801325;4016.975671203883;4037.333839916381;4054.533728621246;1302.9283389413674;1311.5081844308384;1317.9406926688323;1319.22825147288;1325.8806707396188;1362.230339857977;1370.136813807295;1392.0394927499992;1407.6832712639575;1412.6256542016167;8286.4199506034;8378.204070613281;8382.455140415854;8386;8402.915970840213;510.42067253666613;522.5062316111314;528.6563733573208;528.7752705100316;531.2880739808675;6259.624422534572;6285.96857015712;6320.462760665303;6342.080398342307;6357.841053973688;10540.841887371696;10983.945080274547;10989.230753847314;11007.944960275147;11041;10394.740131496774;10712.143028557697;10753.569857205624;10894.128469722404;11107.166962477846;8444.240018398374;8477.98264208299;8515.829683406297;8541.273991710774;8549.316054715608;7977.08263549676;8029.959850200712;8058.798530036796;8302.460340077876;8361.623726932181;9555.61777528891;9584.472853993097;9793.069658382443;9898.802023959624;9996.600135994478;8305.95847020761;10190.541425636013;10370.96290370957;10380.221483388927;10381.532831022772;7293;7560.432967527568;7570.848583028199;7658.2724641159;7743.883841742266;8319.584020799057;8359.791005224917;8402;8415.831683366421;8429.072801991899;7367.631618419165;7457.105147382349;7563.319301262913;7565.6973721050545;7580.317771400601;7289.16174639902;7340.192578816219;7353.191148973501;7499.925000749922;7511.248875112445;7845.097813751491;7855.175206603224;7906.920930790849;7908.881366779618;7915.960420197862;7066.505344626033;7126.714931402686;7138.964305178441;7168.139823221247;7181.461390395637;7140;7142.607156606437;7199.2440793715905;7211.567305961659;7215.639218038972 00:45:15 INFO - PROCESS | 1662 | |4;prototype.html;325.68896703648016;330.33767296570375;335.34942212108524;336.32734530938114;339.92861499085177;6655.771950603959;6692.799216023521;6707.7316907323775;6709.127813384265;6755.493337999651;6666.366695163952;6679.499037572189;6686.197656281241;6694.062831203635;6709.899351509719;4777;4859.715933511244;4869;5012.849614511561;5018.548330650241;4966.478519755427;5007.549320561167;5015.799368025275;5019.749012549376;5021.623378246628;4468.218061839181;4498.437695288089;4952.207646776516;4961.107000739866;4972.627052971024;4704.576588107069;4811.663183577151;4890.902181956377;4922.163232250526;4932;4205.453291072141;4207.852725154636;4209.852655157055;4213.0099426634715;4229.809658565372;6421.8394540136405;6479.83800404989;6482.967585162091;6513.120728701612;6518.608883467007;5876.500497457721;5876.941230587682;5877.706114694291;5879.412058794086;5887.85093440891;6813.386795188457;7157.821054473628;7161.57030578167;7168.641567921583;7171.641417929082;4086.9986853220853;4479.4176757021705;4568.520305367955;4594.862154135381;4629.074185162981;7484.962575187144;7582.924170758277;7583.81040473987;7596.65815038319;7617.847643047108;4647;4666.160091183619;4679.532046795293;4680.7191568506;4680.765961701902;4734.881627959328;4738;4740.691855029412;4741.359916411309;4755.2153894607;5500.6424582402815;5683.556070889557;5693.459121383462;5699.5725320600295;5706.25818643582;7078.469114816409;7177.1746249182015;7187.353138217585;7210.242924492957;7213.242609525924;1585.2232406120918;1620.1332287226278;1643.9725171767645;1645.2185212024192;1646.3990643415307;907.6233363154217;979.2704435195825;1013.159077965287;1031.8400647899587;1060.713607326033;6638.302978187317;6765.424938880152;6775.966120169368;6782.321767823277;6790.456763458911;7493;7493.587852668155;7499.287567681062;7506.924930750732;7509.66206520697;6753.15585551806;6757.161991963387;6762.425193858478;6763.004913550416;6772.830679233059;3788.734788564774;3912.0024393779404;3958.7624742514963;3960.2871483133313;3961.544422391404;6915.478594709156;7503.062117235346;7814.3748500119855;7839.33365663925;7854.410919181084;7629.771106866803;7691.153973062958;7700.306972372401;7703.768886933401;7704.114026886868;7804.297613214838;7810.218978102258;7813.609319534001;7825.804354891174;7834.529928204326;7128.358447739728;7390.076240469942;7434.145073316421;7442.888356674763;7485.139208991036;7264.418846492163;7301.233370496021;7303.196648368781;7309.853802923805;7330.963345183453;7795.025621797276;7796.9220307796195;7799.337056350274;7799.610019499116;7807.375409967302;4678.555537223959;4681.555252251031;4683.297505374221;4688.695234809727;4692.765361731831;7086.681099350439;7403.481756277009;7415.258474152757;7425.806903031748;7465.365443937326;7154.141503019671;7182.174049984319;7186.24544422849;7204.783856484314;7209.891851622335;7167.3907717842485;7176.318249766264;7179.317964793337;7184.712611495482;7189.209186989531;6986.790396288119;7015.158181018311;7016.859662806817;7024.473164512579;7027.6837542309695;6123.663198524124;6761.797146085625;6795.38841504267;7105.076340075964;7174.856502870018;6714.294999025032;6858.5199036067;6912.965435172792;6956.304369563003;7055.541389809851 00:45:15 INFO - PROCESS | 1662 | |5;yui.html;630.2909227119491;696.9581825090495;712.5368510468195;762.5196126440342;766.1572270502448;17891.642167156664;18282.360117395892;18287.54281142972;18319.816801831978;18342.72485912709;16431.507054788344;16475.340986360563;16543.172841357915;16560.503184904443;16594.66810663789;748.0126233371951;757.8332766791325;932.9020452852454;935.8268720286769;949.7910459698855;948.5020364308724;953.4898829126419;953.8140062687779;953.9141477267044;954.3271993244746;1003.8243307421172;1006.3961623026199;1009.8384258518638;1009.9546968887204;1012.3116280928965;797.2943944609004;989.2432289298621;998.181491177235;1002.1531805624236;1002.6390499420203;743.2344684974485;743.8028922335585;744.326384621918;746.6490749347798;746.9589172595505;15607.375704971788;15615.687686246325;15621.843781562153;15627.062376257461;15638.374465021385;11187.32876027441;12935.159214651017;13207.405666744924;13236.801447978289;13492.325383730775;10072.597096116147;10200.387976721346;10263.7434064149;10623.84064239037;11017.724556886062;3560.3413368526903;3589.5154154189113;3604.8017359045243;3666.5416822897137;3711.3319602471543;86517.13482865154;88335.55832220797;88503;88555;88618.99999999936;9746;9781.706548803548;9998.300118991601;10001.24990625706;10149.594016239416;22409.775902241094;22615.208467703553;22622.701686679477;22630.207942722256;22667;7402.888956665654;7544.132424771112;7563.810904727426;7614.771556853303;7735.613219339123;3993.2612466693754;4062.4921884764403;4070.1656160487028;4138.958610413918;4204.054087830214;3666.2667466506805;3689.2252626948643;3699.6300369962787;3710.6474884885893;3711.350513660099;569.5187566506296;630.5586089737202;644.1722386733026;653.6404977262487;655.3970347280418;566.9092945128842;582.5252419278274;591.5504216795181;592.6977241606811;605.3976293587908;7898.249666281809;8302.875456868152;8344.749657510285;8381.07808141104;8501.33082980855;577.255340610616;578.3320265093823;585.9619124756878;607.5929127484596;621.6425555305717;3834.0989867381145;3888.475055867478;3930.0960779020984;3992.540857801332;4070.271367934109;90641.64037539442;92124;92664;92727;92850;79681;79962.6001869987;80502.59748701337;80610;81543.18456815474;60870;60886.695566521885;62039.6898015507;62207.6889615549;63483.36516634867;7824.334931530883;7867.498943075323;7922.762317130495;7938.825165102446;7940.126586075643;38620.03449913775;47660.76169619129;49056.75471622619;49279.08452659542;50306.496935031646;61590.384096158465;62629;65811;66124;67784;10227.43749093807;10309.845352319871;10378.844317335397;10689.09142722846;10950.890491094988;11055.889441105486;11085.889141108486;11422.086233101165;11448.026917712088;11472.88527114718;10464.215183861088;10761.139108871428;10762.892371076188;10790;10863.67408977732;10353.9482302588;10425.374477531372;10443.738906527398;10549.630762923261;11067.889321107008;10040.849387259343;10134.645287414905;10426.68719938403;10444.947775261075;10879;8726.3330517319;8827;8903.06517815646;8925.330600204881;9142.817143657223;6801.897971530332;8880;8937.240334571634;8970.327225458248;9078.682246121354 00:45:15 INFO - PROCESS | 1662 | __end_tp_report 00:45:15 INFO - PROCESS | 1662 | __start_cc_report 00:45:15 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1172 00:45:15 INFO - PROCESS | 1662 | __end_cc_report 00:45:15 INFO - PROCESS | 1662 | __startTimestamp1457599515205__endTimestamp 00:45:15 INFO - PROCESS | 1662 | 00:45:15 INFO - PROCESS | 1662 | ------- Summary: start ------- 00:45:15 INFO - PROCESS | 1662 | Number of tests: 6 00:45:15 INFO - PROCESS | 1662 | 00:45:15 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5658.91 Median:5852.50 stddev:652.95 (11.2%) stddev-sans-first:610.45 00:45:15 INFO - PROCESS | 1662 | Values: 2638.6 3393.1 3399.6 3454.1 3495.3 5495.9 5544.1 5614.1 5649.0 5658.3 5532.1 5630.6 5631.9 5633.3 5635.7 5075.4 5122.3 5122.6 5176.2 5205.0 4342.0 5132.9 5181.3 5207.0 5234.6 5167.5 5176.5 5194.6 5223.3 5245.1 5180.8 5215.7 5234.2 5236.1 5259.3 4125.5 5064.6 5097.0 5136.9 5185.9 5519.4 5528.1 5550.7 5573.3 5614.4 6152.4 6180.2 6188.6 6204.1 6205.8 6040.9 6084.0 6154.9 6187.3 6204.8 5655.5 5680.7 5685.3 5688.3 5727.3 5537.3 5942.4 6255.8 6309.1 6367.7 5915.8 6012.5 6045.6 6108.1 6122.7 6136.4 6152.9 6153.6 6163.5 6164.5 6060.6 6065.8 6086.8 6089.7 6104.8 6045.1 6131.3 6156.5 6176.4 6187.9 4833.6 4849.2 4864.6 4880.9 4898.8 4277.5 4351.6 4387.0 4392.1 4423.4 5537.3 5552.4 5606.0 5612.8 5759.5 6227.6 6237.3 6256.6 6262.1 6274.6 5643.9 5652.9 5662.5 5673.8 5725.9 5223.3 5289.1 5315.1 5325.2 5327.9 6246.1 6282.4 6290.1 6294.8 6306.0 5965.8 6089.8 6090.8 6094.8 6127.4 6223.1 6239.4 6287.4 6304.6 6385.2 6101.7 6121.0 6124.7 6131.3 6132.3 6149.2 6166.4 6203.2 6219.5 6227.6 5828.2 5947.2 5971.5 6054.7 6104.8 5921.9 5994.7 6010.4 6010.9 6012.0 5697.4 5867.3 5885.2 5912.1 5916.1 5824.9 5981.3 6030.7 6043.5 6085.9 5824.1 5846.2 5846.6 5852.5 5854.1 00:45:15 INFO - PROCESS | 1662 | 00:45:15 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:60238.83 Median:36180.95 stddev:121785.26 (336.6%) stddev-sans-first:122044.33 00:45:15 INFO - PROCESS | 1662 | Values: 506.7 527.7 588.4 640.6 643.5 25003.7 31001.2 31044.0 38908.0 39271.6 42541.8 42854.6 42966.4 43042.9 43077.4 9601.5 9815.8 9875.2 9877.2 9894.1 9621.7 9757.2 9760.5 9783.2 9783.3 9751.8 9821.1 9823.7 9958.2 9985.4 9864.3 9920.9 9925.6 9930.3 9938.1 9797.9 9928.4 9929.9 9932.0 9937.8 36562.6 39231.8 41593.2 41598.4 41732.6 3163.7 3180.4 3210.0 3232.0 3408.2 28867.6 28893.3 29039.8 29216.3 29311.1 2755.2 2797.4 2799.6 2805.1 2863.3 496238.0 496462.0 497994.5 498532.5 499993.0 66580.7 67971.3 68514.0 68605.3 68779.7 74427.3 75549.6 75710.2 75771.9 75850.6 17010.8 17195.9 17198.0 17245.0 17262.6 12888.8 13008.3 13011.3 13045.3 13074.5 16960.5 20890.4 20963.7 21322.6 21358.0 7794.4 9153.0 9162.5 9166.5 9173.0 899.5 927.8 981.4 1017.8 1091.3 29645.4 29802.7 30078.4 30089.0 30540.1 1009.3 1089.7 1103.7 1105.6 1255.9 12298.3 15097.8 15172.8 15227.1 15358.0 527882.0 532518.0 532687.0 533954.0 535850.0 59908.4 60601.4 60674.4 60838.0 60862.4 1304.1 1380.1 1421.7 1444.4 1588.3 22107.7 28721.4 29356.7 29455.4 30684.7 46438.3 47050.5 47062.8 47085.8 47110.8 301160.0 312412.0 313271.0 313856.0 314098.0 28748.3 33335.3 33569.5 33865.7 33977.0 41606.8 42572.9 42812.8 42985.5 43204.6 34187.8 35052.0 35179.6 35726.0 35961.6 35147.6 35226.0 35746.3 35966.9 36001.3 36015.0 36346.9 36488.5 36700.6 36969.3 31996.7 32408.0 32617.7 32678.7 32752.8 23277.9 24030.0 24438.5 24874.6 24982.5 00:45:15 INFO - PROCESS | 1662 | 00:45:15 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:33658.06 Median:14108.19 stddev:100740.95 (714.1%) stddev-sans-first:100992.44 00:45:15 INFO - PROCESS | 1662 | Values: 311.2 358.6 362.5 367.4 371.0 20510.0 21144.8 21812.0 22000.4 22316.8 19087.9 20229.8 20682.5 21358.8 21429.7 5839.1 6025.3 6026.2 6056.6 6079.1 5529.1 5803.3 5811.2 5811.6 5949.9 4790.2 5791.5 5802.4 5803.3 5807.3 5581.2 5752.8 5843.2 5845.6 5881.6 5567.3 5585.9 5587.8 5591.2 5606.0 13710.9 18885.9 19671.1 25650.9 25670.4 2040.1 2171.4 2248.7 2469.1 2565.5 9862.5 10011.3 10195.2 10286.8 10305.5 1762.2 1803.7 1807.6 1874.6 1891.6 95278.5 96927.0 105930.0 105982.5 107663.5 10761.0 11214.3 11263.8 11331.9 11382.9 13486.7 13576.9 13595.1 13602.0 13610.9 8605.0 8626.7 8648.5 8710.3 8741.9 8885.6 8892.4 8900.0 8975.9 8983.1 4486.4 4503.5 4519.5 4542.5 4603.6 1851.8 1881.9 1893.1 1898.1 1915.9 874.7 904.6 945.7 978.0 988.0 19756.6 20057.5 20149.3 20384.6 20953.7 952.3 970.4 971.9 989.2 1068.6 10752.5 11109.8 11154.8 11163.6 11273.9 577891.0 603962.8 613163.0 619392.0 631807.0 101968.5 104602.5 104873.5 104948.0 107790.5 999.1 1003.4 1019.9 1020.4 1021.5 13361.5 15265.7 18039.0 18286.8 18483.8 48774.4 48921.0 49348.3 50300.7 50766.5 70104.0 70117.9 70945.0 71355.0 71958.3 7593.7 7596.7 7622.2 7739.3 7921.9 11857.9 12038.9 12110.5 12144.8 12330.8 8310.1 10115.6 10590.6 10627.0 10685.0 9549.5 9576.1 10229.0 10525.8 10651.6 8950.4 10532.7 10706.3 10988.6 11041.0 7537.7 7657.2 7771.7 7806.8 7924.3 10111.2 10578.8 10655.5 10905.5 10906.0 00:45:15 INFO - PROCESS | 1662 | 00:45:15 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6169.80 Median:525.58 stddev:3292.92 (626.5%) stddev-sans-first:3283.08 00:45:15 INFO - PROCESS | 1662 | Values: 1453.9 1593.6 1624.3 1919.0 2057.6 8117.6 8843.2 9016.4 9022.7 9029.3 8735.0 8958.8 8969.1 8974.3 9040.4 2181.4 2438.8 2473.4 2506.6 2513.0 2517.4 2524.8 2525.3 2526.2 2541.1 2413.3 2472.3 2479.9 2481.2 2485.7 2177.4 2434.3 2469.2 2499.6 2501.5 2386.7 2421.9 2437.6 2490.1 2512.5 8965.1 9048.6 9049.2 9053.5 9059.4 5538.5 5676.3 5681.2 5686.4 5691.7 3586.8 3727.9 3757.1 3766.3 3783.9 1031.4 1059.4 1070.4 1071.1 1083.5 12300.9 12308.5 12311.9 12314.8 12322.4 4061.2 4953.6 5077.6 5080.8 5100.7 10390.6 10403.8 10404.3 10408.3 10410.0 5596.6 5607.3 5629.1 5640.5 5644.8 4481.9 4639.8 4882.6 4993.2 5036.2 3355.7 3953.4 4017.0 4037.3 4054.5 1302.9 1311.5 1317.9 1319.2 1325.9 1362.2 1370.1 1392.0 1407.7 1412.6 8286.4 8378.2 8382.5 8386.0 8402.9 510.4 522.5 528.7 528.8 531.3 6259.6 6286.0 6320.5 6342.1 6357.8 10540.8 10983.9 10989.2 11007.9 11041.0 10394.7 10712.1 10753.6 10894.1 11107.2 8444.2 8478.0 8515.8 8541.3 8549.3 7977.1 8030.0 8058.8 8302.5 8361.6 9555.6 9584.5 9793.1 9898.8 9996.6 8306.0 10190.5 10371.0 10380.2 10381.5 7293.0 7560.4 7570.8 7658.3 7743.9 8319.6 8359.8 8402.0 8415.8 8429.1 7367.6 7457.1 7563.3 7565.7 7580.3 7289.2 7340.2 7353.2 7499.9 7511.2 7845.1 7855.2 7906.9 7908.9 7916.0 7066.5 7126.7 7139.0 7168.1 7181.5 7140.0 7142.6 7199.2 7211.6 7215.6 00:45:15 INFO - PROCESS | 1662 | 00:45:15 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5873.87 Median:6754.32 stddev:1894.38 (28.0%) stddev-sans-first:1853.36 00:45:15 INFO - PROCESS | 1662 | Values: 325.7 330.3 335.3 336.3 339.9 6655.8 6692.8 6707.7 6709.1 6755.5 6666.4 6679.5 6686.2 6694.1 6709.9 4777.0 4859.7 4869.0 5012.8 5018.5 4966.5 5007.5 5015.8 5019.7 5021.6 4468.2 4498.4 4952.2 4961.1 4972.6 4704.6 4811.7 4890.9 4922.2 4932.0 4205.5 4207.9 4209.9 4213.0 4229.8 6421.8 6479.8 6483.0 6513.1 6518.6 5876.5 5876.9 5877.7 5879.4 5887.9 6813.4 7157.8 7161.6 7168.6 7171.6 4087.0 4479.4 4568.5 4594.9 4629.1 7485.0 7582.9 7583.8 7596.7 7617.8 4647.0 4666.2 4679.5 4680.7 4680.8 4734.9 4738.0 4740.7 4741.4 4755.2 5500.6 5683.6 5693.5 5699.6 5706.3 7078.5 7177.2 7187.4 7210.2 7213.2 1585.2 1620.1 1644.0 1645.2 1646.4 907.6 979.3 1013.2 1031.8 1060.7 6638.3 6765.4 6776.0 6782.3 6790.5 7493.0 7493.6 7499.3 7506.9 7509.7 6753.2 6757.2 6762.4 6763.0 6772.8 3788.7 3912.0 3958.8 3960.3 3961.5 6915.5 7503.1 7814.4 7839.3 7854.4 7629.8 7691.2 7700.3 7703.8 7704.1 7804.3 7810.2 7813.6 7825.8 7834.5 7128.4 7390.1 7434.1 7442.9 7485.1 7264.4 7301.2 7303.2 7309.9 7331.0 7795.0 7796.9 7799.3 7799.6 7807.4 4678.6 4681.6 4683.3 4688.7 4692.8 7086.7 7403.5 7415.3 7425.8 7465.4 7154.1 7182.2 7186.2 7204.8 7209.9 7167.4 7176.3 7179.3 7184.7 7189.2 6986.8 7015.2 7016.9 7024.5 7027.7 6123.7 6761.8 6795.4 7105.1 7174.9 6714.3 6858.5 6913.0 6956.3 7055.5 00:45:15 INFO - PROCESS | 1662 | 00:45:15 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18268.78 Median:573.39 stddev:25727.61 (4487.0%) stddev-sans-first:25765.70 00:45:15 INFO - PROCESS | 1662 | Values: 630.3 697.0 712.5 762.5 766.2 17891.6 18282.4 18287.5 18319.8 18342.7 16431.5 16475.3 16543.2 16560.5 16594.7 748.0 757.8 932.9 935.8 949.8 948.5 953.5 953.8 953.9 954.3 1003.8 1006.4 1009.8 1010.0 1012.3 797.3 989.2 998.2 1002.2 1002.6 743.2 743.8 744.3 746.6 747.0 15607.4 15615.7 15621.8 15627.1 15638.4 11187.3 12935.2 13207.4 13236.8 13492.3 10072.6 10200.4 10263.7 10623.8 11017.7 3560.3 3589.5 3604.8 3666.5 3711.3 86517.1 88335.6 88503.0 88555.0 88619.0 9746.0 9781.7 9998.3 10001.2 10149.6 22409.8 22615.2 22622.7 22630.2 22667.0 7402.9 7544.1 7563.8 7614.8 7735.6 3993.3 4062.5 4070.2 4139.0 4204.1 3666.3 3689.2 3699.6 3710.6 3711.4 569.5 630.6 644.2 653.6 655.4 566.9 582.5 591.6 592.7 605.4 7898.2 8302.9 8344.7 8381.1 8501.3 577.3 578.3 586.0 607.6 621.6 3834.1 3888.5 3930.1 3992.5 4070.3 90641.6 92124.0 92664.0 92727.0 92850.0 79681.0 79962.6 80502.6 80610.0 81543.2 60870.0 60886.7 62039.7 62207.7 63483.4 7824.3 7867.5 7922.8 7938.8 7940.1 38620.0 47660.8 49056.8 49279.1 50306.5 61590.4 62629.0 65811.0 66124.0 67784.0 10227.4 10309.8 10378.8 10689.1 10950.9 11055.9 11085.9 11422.1 11448.0 11472.9 10464.2 10761.1 10762.9 10790.0 10863.7 10353.9 10425.4 10443.7 10549.6 11067.9 10040.8 10134.6 10426.7 10444.9 10879.0 8726.3 8827.0 8903.1 8925.3 9142.8 6801.9 8880.0 8937.2 8970.3 9078.7 00:45:15 INFO - PROCESS | 1662 | -------- Summary: end -------- 00:45:15 INFO - PROCESS | 1662 | 00:45:15 INFO - TEST-INFO | 1662: exit 0 00:45:15 INFO - TEST-OK | dromaeo_css | took 1112613ms 00:45:15 INFO - TEST-START | kraken 00:45:15 INFO - operating with platform_type : mac_ 00:45:15 INFO - Initialising browser for kraken test... 00:45:15 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpaxaYrj/profile http://localhost:49271/getInfo.html) 00:45:17 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 00:45:17 INFO - PROCESS | 1672 | colorDepth:24 00:45:17 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 00:45:17 INFO - PROCESS | 1672 | __metrics 00:45:18 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:45:18 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:45:18 INFO - TEST-INFO | 1672: exit 0 00:45:18 INFO - Browser initialized. 00:45:18 INFO - Running cycle 1/1 for kraken test... 00:45:18 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpaxaYrj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:45:30 INFO - PROCESS | 1674 | RSS: Main: 241344512 00:45:30 INFO - PROCESS | 1674 | 00:45:33 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 00:45:33 INFO - PROCESS | 1674 | RSS: Main: 288538624 00:45:33 INFO - PROCESS | 1674 | 00:45:36 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 00:45:36 INFO - PROCESS | 1674 | RSS: Main: 300257280 00:45:36 INFO - PROCESS | 1674 | 00:45:40 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 00:45:40 INFO - PROCESS | 1674 | RSS: Main: 288911360 00:45:40 INFO - PROCESS | 1674 | 00:45:42 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 00:45:43 INFO - PROCESS | 1674 | RSS: Main: 290009088 00:45:43 INFO - PROCESS | 1674 | 00:45:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:45:45 INFO - PROCESS | 1674 | RSS: Main: 289955840 00:45:45 INFO - PROCESS | 1674 | 00:45:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 00:45:49 INFO - PROCESS | 1674 | RSS: Main: 291495936 00:45:49 INFO - PROCESS | 1674 | 00:45:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 00:45:52 INFO - PROCESS | 1674 | RSS: Main: 290832384 00:45:52 INFO - PROCESS | 1674 | 00:45:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 00:45:56 INFO - PROCESS | 1674 | RSS: Main: 290676736 00:45:56 INFO - PROCESS | 1674 | 00:45:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:45:58 INFO - PROCESS | 1674 | RSS: Main: 325120000 00:45:58 INFO - PROCESS | 1674 | 00:45:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:46:00 INFO - PROCESS | 1674 | RSS: Main: 324505600 00:46:00 INFO - PROCESS | 1674 | 00:46:02 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:46:03 INFO - PROCESS | 1674 | RSS: Main: 330190848 00:46:03 INFO - PROCESS | 1674 | 00:46:05 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:46:06 INFO - PROCESS | 1674 | RSS: Main: 331972608 00:46:06 INFO - PROCESS | 1674 | 00:46:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:46:09 INFO - PROCESS | 1674 | RSS: Main: 332283904 00:46:09 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 00:46:11 INFO - PROCESS | 1674 | RSS: Main: 392294400 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | __start_tp_report 00:46:11 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 00:46:11 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 00:46:11 INFO - PROCESS | 1674 | |i|pagename|runs| 00:46:11 INFO - PROCESS | 1674 | |0;ai-astar;111;107;111;112;111;111;115;112;112;111 00:46:11 INFO - PROCESS | 1674 | |1;audio-beat-detection;157;120;146;156;114;144;139;122;170;147 00:46:11 INFO - PROCESS | 1674 | |2;audio-dft;186;183;186;186;183;185;188;184;181;181 00:46:11 INFO - PROCESS | 1674 | |3;audio-fft;75;73;84;77;56;57;57;79;76;54 00:46:11 INFO - PROCESS | 1674 | |4;audio-oscillator;95;91;130;80;83;85;115;106;114;124 00:46:11 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;87;83;85;83;86;83;86;84;85;84 00:46:11 INFO - PROCESS | 1674 | |6;imaging-darkroom;93;93;92;93;92;92;105;148;92;92 00:46:11 INFO - PROCESS | 1674 | |7;imaging-desaturate;85;84;87;85;83;90;84;85;84;82 00:46:11 INFO - PROCESS | 1674 | |8;json-parse-financial;54;56;53;53;52;54;56;63;54;52 00:46:11 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;63;70;66;73;69;67;67;66;67;68 00:46:11 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;97;97;106;83;83;81;81;82;82;82 00:46:11 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;132;127;131;123;120;120;119;126;124;130 00:46:11 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;156;128;137;138;138;126;138;135;136;137 00:46:11 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;66;66;66;68;66;68;68;67;68 00:46:11 INFO - PROCESS | 1674 | __end_tp_report 00:46:11 INFO - PROCESS | 1674 | __start_cc_report 00:46:11 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1218 00:46:11 INFO - PROCESS | 1674 | __end_cc_report 00:46:11 INFO - PROCESS | 1674 | __startTimestamp1457599571493__endTimestamp 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | ------- Summary: start ------- 00:46:11 INFO - PROCESS | 1674 | Number of tests: 14 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:1.95 (1.7%) stddev-sans-first:2.06 00:46:11 INFO - PROCESS | 1674 | Values: 111.0 107.0 111.0 112.0 111.0 111.0 115.0 112.0 112.0 111.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:146.50 stddev:18.03 (12.3%) stddev-sans-first:18.23 00:46:11 INFO - PROCESS | 1674 | Values: 157.0 120.0 146.0 156.0 114.0 144.0 139.0 122.0 170.0 147.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.50 stddev:2.31 (1.2%) stddev-sans-first:2.37 00:46:11 INFO - PROCESS | 1674 | Values: 186.0 183.0 186.0 186.0 183.0 185.0 188.0 184.0 181.0 181.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:68.80 Median:75.50 stddev:11.41 (15.1%) stddev-sans-first:11.88 00:46:11 INFO - PROCESS | 1674 | Values: 75.0 73.0 84.0 77.0 56.0 57.0 57.0 79.0 76.0 54.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:81.50 stddev:17.95 (22.0%) stddev-sans-first:18.84 00:46:11 INFO - PROCESS | 1674 | Values: 95.0 91.0 130.0 80.0 83.0 85.0 115.0 106.0 114.0 124.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:84.60 Median:85.00 stddev:1.43 (1.7%) stddev-sans-first:1.22 00:46:11 INFO - PROCESS | 1674 | Values: 87.0 83.0 85.0 83.0 86.0 83.0 86.0 84.0 85.0 84.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:92.00 stddev:17.61 (19.1%) stddev-sans-first:18.53 00:46:11 INFO - PROCESS | 1674 | Values: 93.0 93.0 92.0 93.0 92.0 92.0 105.0 148.0 92.0 92.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:2.23 (2.6%) stddev-sans-first:2.37 00:46:11 INFO - PROCESS | 1674 | Values: 85.0 84.0 87.0 85.0 83.0 90.0 84.0 85.0 84.0 82.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.00 stddev:3.23 (6.0%) stddev-sans-first:3.42 00:46:11 INFO - PROCESS | 1674 | Values: 54.0 56.0 53.0 53.0 52.0 54.0 56.0 63.0 54.0 52.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:2.67 (4.0%) stddev-sans-first:2.26 00:46:11 INFO - PROCESS | 1674 | Values: 63.0 70.0 66.0 73.0 69.0 67.0 67.0 66.0 67.0 68.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:82.50 stddev:9.06 (11.0%) stddev-sans-first:8.92 00:46:11 INFO - PROCESS | 1674 | Values: 97.0 97.0 106.0 83.0 83.0 81.0 81.0 82.0 82.0 82.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.50 stddev:4.78 (3.8%) stddev-sans-first:4.39 00:46:11 INFO - PROCESS | 1674 | Values: 132.0 127.0 131.0 123.0 120.0 120.0 119.0 126.0 124.0 130.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.90 Median:137.50 stddev:7.96 (5.8%) stddev-sans-first:4.55 00:46:11 INFO - PROCESS | 1674 | Values: 156.0 128.0 137.0 138.0 138.0 126.0 138.0 135.0 136.0 137.0 00:46:11 INFO - PROCESS | 1674 | 00:46:11 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:0.94 (1.4%) stddev-sans-first:1.00 00:46:11 INFO - PROCESS | 1674 | Values: 67.0 66.0 66.0 66.0 68.0 66.0 68.0 68.0 67.0 68.0 00:46:11 INFO - PROCESS | 1674 | -------- Summary: end -------- 00:46:11 INFO - PROCESS | 1674 | 00:46:12 INFO - TEST-INFO | 1674: exit 0 00:46:12 INFO - TEST-OK | kraken | took 56479ms 00:46:12 INFO - SUITE-END | took 1169s 00:46:12 INFO - Completed test suite (00:19:29) 00:46:12 INFO - javascript benchmark 00:46:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2638.6437830892837, 3393.0838673558137, 3399.62026581393, 3454.1191996041007, 3495.2659941412303, 5495.890082198353, 5544.0575102232615, 5614.0736778431565, 5649.0, 5658.292713410819, 5532.114861622142, 5630.605857589971, 5631.943680563193, 5633.267675202228, 5635.718214089299, 5075.365579302587, 5122.257272695457, 5122.564582010515, 5176.223566465042, 5204.959008198357, 4342.0, 5132.8973420531565, 5181.3264275644115, 5207.0, 5234.555062819665, 5167.534921857032, 5176.50823171798, 5194.584433245332, 5223.320968274119, 5245.082110630643, 5180.792768289264, 5215.713135777531, 5234.18870075139, 5236.083685355047, 5259.342582177228, 4125.50493940726, 5064.594832413435, 5097.0315640028275, 5136.897262054776, 5185.922211166836, 5519.420460851593, 5528.06022976091, 5550.69471179085, 5573.27547418833, 5614.438556144394, 6152.3847615238565, 6180.196574445338, 6188.597741146856, 6204.100405441186, 6205.844853878644, 6040.911097991169, 6084.0, 6154.857080275961, 6187.319394866561, 6204.7828326008375, 5655.462731040545, 5680.6591604503865, 5685.346185188715, 5688.345840228427, 5727.312722473288, 5537.252470916455, 5942.405759424109, 6255.812325630239, 6309.08518264849, 6367.745290188341, 5915.792947246911, 6012.549058820518, 6045.607035542764, 6108.129596501707, 6122.703114648715, 6136.386361363828, 6152.907706384408, 6153.600015998945, 6163.537734669918, 6164.537659675452, 6060.606060606135, 6065.8180254592435, 6086.756529738761, 6089.725962331706, 6104.847378815565, 6045.063015232646, 6131.294901086432, 6156.476699480594, 6176.3514830943, 6187.938120618826, 4833.637477189154, 4849.224124140121, 4864.586510146677, 4880.853574392774, 4898.779554920037, 4277.465316835395, 4351.608355248043, 4386.978065109654, 4392.05570802279, 4423.447069116361, 5537.335519737658, 5552.3892371839065, 5605.971970140124, 5612.775488980476, 5759.51044161251, 6227.626342419469, 6237.251529816451, 6256.624602523863, 6262.091996660459, 6274.592151510228, 5643.943560564424, 5652.851231879038, 5662.518685911744, 5673.8297851064535, 5725.914111288334, 5223.2948551945, 5289.127293996447, 5315.123004704181, 5325.227841962894, 5327.920081198785, 6246.063090536456, 6282.371762823681, 6290.119383286435, 6294.842628934313, 6305.96847015762, 5965.791197308074, 6089.817305480666, 6090.786822461193, 6094.786682466092, 6127.417895300117, 6223.066540019034, 6239.376062393906, 6287.371262873676, 6304.5586808922935, 6385.201849768779, 6101.6644084574, 6121.0206366981065, 6124.724387402489, 6131.325554188947, 6132.2947860996555, 6149.2313460817395, 6166.383903917073, 6203.2245969253845, 6219.533534984804, 6227.626342419469, 5828.184054232326, 5947.2393490801005, 5971.462568368867, 6054.727537260922, 6104.816855494342, 5921.940780592139, 5994.700264986646, 6010.368911264429, 6010.909836352545, 6012.0, 5697.401772813795, 5867.266591676041, 5885.234919460443, 5912.113183022581, 5916.083007133901, 5824.912626310694, 5981.252343457068, 6030.698465076816, 6043.516518678583, 6085.908711369245, 5824.068149096124, 5846.239988801429, 5846.649201047951, 5852.502537284378, 5854.063349864001], "unit": "score", "name": "dojo.html", "value": 5615.967908775508}, {"lowerIsBetter": false, "replicates": [506.6858547700426, 527.7361319340328, 588.393954227146, 640.6156306216271, 643.5173619785161, 25003.74996250037, 31001.224969375777, 31044.0, 38908.02729931753, 39271.60728392715, 42541.78729106358, 42854.57145428545, 42966.35550466745, 43042.92392690184, 43077.353839692354, 9601.471919044432, 9815.803683926317, 9875.160611348045, 9877.160441362494, 9894.060064293917, 9621.663241786538, 9757.219422446222, 9760.511974401286, 9783.168430683401, 9783.315167938246, 9751.75620609487, 9821.066998635153, 9823.65617203398, 9958.20334373252, 9985.35095218812, 9864.260180486457, 9920.90079099207, 9925.553350099262, 9930.255230857678, 9938.055884690943, 9797.853032204523, 9928.404295742279, 9929.90070099297, 9932.006799320083, 9937.80124397508, 36562.63437365619, 39231.80384098061, 41593.1681366374, 41598.376024359655, 41732.58267417348, 3163.715265626082, 3180.4434224010706, 3209.9679003210135, 3231.9958643178197, 3408.16499957512, 28867.576869782002, 28893.29165090306, 29039.803322417793, 29216.269593260127, 29311.120666380044, 2755.2423083651956, 2797.4125433658955, 2799.6080548723194, 2805.0743254726094, 2863.298491869505, 496238.0, 496462.0, 497994.51002745115, 498532.5073374646, 499993.0, 66580.66709666517, 67971.3202867965, 68514.0, 68605.31394686089, 68779.74643042767, 74427.25572744312, 75549.62225188839, 75710.24289757032, 75771.86342204761, 75850.62074689701, 17010.82989170117, 17195.914020429816, 17198.0, 17245.0, 17262.568435789206, 12888.80666789999, 13008.349582520836, 13011.349432528525, 13045.34773261333, 13074.477020919057, 16960.491185264214, 20890.404111095533, 20963.685544716536, 21322.573548529253, 21358.0, 7794.363183731367, 9152.954235228914, 9162.450252984841, 9166.541672916328, 9173.0, 899.4827973915025, 927.7912469694264, 981.4356744871727, 1017.8320577104843, 1091.2852081886376, 29645.407091858044, 29802.65847651142, 30078.398432031237, 30089.0, 30540.08379748611, 1009.3287963504334, 1089.6948854320644, 1103.7406209540752, 1105.5743538737484, 1255.9309237991815, 12298.262104273772, 15097.773533397009, 15172.750896548945, 15227.086374817547, 15358.0, 527882.0, 532518.0, 532687.0, 533954.0, 535850.0, 59908.400915990285, 60601.39398606046, 60674.39325606776, 60838.0, 60862.391376085674, 1304.067591671959, 1380.0960370957039, 1421.7156568686305, 1444.415011920174, 1588.348777001447, 22107.668384973917, 28721.42557148887, 29356.706432935396, 29455.410891781616, 30684.693153068183, 46438.30342544932, 47050.52949470598, 47062.82342941454, 47085.822854428916, 47110.76444617755, 301160.0, 312412.0, 313271.0, 313856.0, 314098.0, 28748.281292967844, 33335.33323333872, 33569.47520510311, 33865.66134338625, 33977.0, 41606.79196603998, 42572.93567660709, 42812.78593607136, 42985.495507657084, 43204.56795432131, 34187.829060854536, 35052.0, 35179.64820351764, 35726.0, 35961.640383596874, 35147.648523514436, 35226.0, 35746.28507429889, 35966.920992369225, 36001.27997440089, 36015.0, 36346.90959271226, 36488.452673209395, 36700.63299366972, 36969.260614788094, 31996.68003319937, 32408.0, 32617.673823261463, 32678.673213267564, 32752.83623581962, 23277.883610581837, 24030.0, 24438.51122977495, 24874.626880596443, 24982.50034999326], "unit": "score", "name": "ext.html", "value": 19679.180612814787}, {"lowerIsBetter": false, "replicates": [311.2266018942926, 358.5876242321331, 362.52690239237785, 367.419477225983, 370.9946046214758, 20510.0, 21144.837033963126, 21811.99999999998, 22000.44998875029, 22316.764069209956, 19087.85472871625, 20229.797702022974, 20682.48293792656, 21358.786412135913, 21429.67855482169, 5839.124131380285, 6025.3372129065765, 6026.186464827236, 6056.60632058917, 6079.118527813464, 5529.115341545354, 5803.274590676166, 5811.244538210027, 5811.593188476808, 5949.9107513387335, 4790.23356262998, 5791.536677065825, 5802.448767367094, 5803.303603567578, 5807.332156801958, 5581.2186293918885, 5752.7986520471795, 5843.2403787507565, 5845.561582881259, 5881.647101173943, 5567.276254086943, 5585.888282234373, 5587.776488940438, 5591.189277554772, 5605.971970140164, 13710.862891371058, 18885.905570472198, 19671.114799834042, 25650.871745641154, 25670.358241044123, 2040.0819631166034, 2171.4462811983003, 2248.7182306085538, 2469.1481438903547, 2565.512552615016, 9862.45756483393, 10011.299209055369, 10195.184385249237, 10286.845697314546, 10305.484725763681, 1762.189392879277, 1803.6573051120245, 1807.6384723055442, 1874.6250749850085, 1891.6311319292743, 95278.52360738222, 96927.0, 105930.0, 105982.47008764984, 107663.46168269108, 10761.031507164236, 11214.271072380432, 11263.831042534368, 11331.886681133248, 11382.886171138183, 13486.730265394834, 13576.93211533936, 13595.116317439335, 13602.0, 13610.863891361158, 8604.956975215084, 8626.741197764077, 8648.481091134552, 8710.25962793157, 8741.91258087411, 8885.644574217089, 8892.377533572588, 8900.0, 8975.865362019575, 8983.056779038106, 4486.394336764561, 4503.527129651405, 4519.525449827721, 4542.545745425431, 4603.585677288993, 1851.8425933795509, 1881.8870867747978, 1893.1480833624923, 1898.0984032584413, 1915.8754680945694, 874.728834061443, 904.6426661468684, 945.6784693204344, 977.9804403911882, 987.9703608891745, 19756.60486790285, 20057.498562536053, 20149.294774682814, 20384.592308153755, 20953.68569471459, 952.3048174832272, 970.4225985538593, 971.8882328532168, 989.218517371283, 1068.625980906692, 10752.462376881125, 11109.778044391154, 11154.776904461865, 11163.60454943132, 11273.887261127284, 577891.0, 603962.7820469829, 613163.0, 619392.0, 631807.0, 101968.49015754873, 104602.47698761457, 104873.47563262288, 104947.95052049535, 107790.46104769426, 999.0608827701936, 1003.4330603209163, 1019.9235057370727, 1020.3724709303725, 1021.4841505040056, 13361.53234636783, 15265.694686106437, 18039.0, 18286.817131828513, 18483.815161848208, 48774.44862668374, 48921.0, 49348.25977610267, 50300.74849625875, 50766.492335076175, 70104.0, 70117.94823077555, 70945.0, 71355.0, 71958.28041719516, 7593.696252149852, 7596.734114305973, 7622.16156222804, 7739.3034626883855, 7921.881171782313, 11857.940710296394, 12038.939805300917, 12110.45502952387, 12144.817827732768, 12330.75338493243, 8310.052067623648, 10115.595376185165, 10590.576376944837, 10627.0, 10685.038346548848, 9549.52252387364, 9576.138147566753, 10229.0, 10525.78948421012, 10651.627193048205, 8950.418222815497, 10532.684019479428, 10706.250562460553, 10988.615398461016, 11041.00630943219, 7537.736179233701, 7657.157712651492, 7771.650275737718, 7806.765797026098, 7924.286814186751, 10111.241656875616, 10578.788424231318, 10655.520501577292, 10905.454727263446, 10906.0], "unit": "score", "name": "jquery.html", "value": 9239.959253011793}, {"lowerIsBetter": false, "replicates": [1453.941842326307, 1593.5617705131092, 1624.2934323569248, 1918.9712154317688, 2057.578196469723, 8117.63470643821, 8843.204111629952, 9016.413933094353, 9022.729318120468, 9029.32280078995, 8734.956325218382, 8958.776030599238, 8969.103089691027, 8974.282057435406, 9040.367174297802, 2181.4001149683886, 2438.756124387565, 2473.4187465945533, 2506.6490691303143, 2513.0324824942345, 2517.420993171572, 2524.798016158703, 2525.318164095693, 2526.1916186820226, 2541.1106112860534, 2413.337652951871, 2472.344828620417, 2479.913203037894, 2481.1936120760734, 2485.6768620079456, 2177.433867194525, 2434.3427274635837, 2469.2468797016904, 2499.5875680512695, 2501.524710305054, 2386.7135943686867, 2421.9152329668555, 2437.622168563875, 2490.1160088168804, 2512.522620702079, 8965.148310910517, 9048.592813323416, 9049.2308153807, 9053.4567925924, 9059.365844390895, 5538.47384498472, 5676.318841739017, 5681.23303354046, 5686.3744988051285, 5691.658500489983, 3586.8027258500774, 3727.925441491182, 3757.079515518715, 3766.3408903442064, 3783.921582349017, 1031.3554028732042, 1059.390850261103, 1070.4005756776153, 1071.1056268016216, 1083.4582708645678, 12300.892919637186, 12308.507659693601, 12311.876881231252, 12314.753704925852, 12322.445489952974, 4061.2283666103344, 4953.578945789576, 5077.568406685399, 5080.796768129308, 5100.668456550312, 10390.636327728493, 10403.791924161626, 10404.323718958394, 10408.323458975143, 10409.95900409953, 5596.636218645856, 5607.271054762855, 5629.0712032514175, 5640.492355687926, 5644.8024319148635, 4481.932771008437, 4639.837605683785, 4882.609391248691, 4993.151164302078, 5036.219385995103, 3355.6644335566734, 3953.3872249801325, 4016.975671203883, 4037.333839916381, 4054.533728621246, 1302.9283389413674, 1311.5081844308384, 1317.9406926688323, 1319.22825147288, 1325.8806707396188, 1362.230339857977, 1370.136813807295, 1392.0394927499992, 1407.6832712639575, 1412.6256542016167, 8286.4199506034, 8378.204070613281, 8382.455140415854, 8386.0, 8402.915970840213, 510.42067253666613, 522.5062316111314, 528.6563733573208, 528.7752705100316, 531.2880739808675, 6259.624422534572, 6285.96857015712, 6320.462760665303, 6342.080398342307, 6357.841053973688, 10540.841887371696, 10983.945080274547, 10989.230753847314, 11007.944960275147, 11041.0, 10394.740131496774, 10712.143028557697, 10753.569857205624, 10894.128469722404, 11107.166962477846, 8444.240018398374, 8477.98264208299, 8515.829683406297, 8541.273991710774, 8549.316054715608, 7977.08263549676, 8029.959850200712, 8058.798530036796, 8302.460340077876, 8361.623726932181, 9555.61777528891, 9584.472853993097, 9793.069658382443, 9898.802023959624, 9996.600135994478, 8305.95847020761, 10190.541425636013, 10370.96290370957, 10380.221483388927, 10381.532831022772, 7293.0, 7560.432967527568, 7570.848583028199, 7658.2724641159, 7743.883841742266, 8319.584020799057, 8359.791005224917, 8402.0, 8415.831683366421, 8429.072801991899, 7367.631618419165, 7457.105147382349, 7563.319301262913, 7565.6973721050545, 7580.317771400601, 7289.16174639902, 7340.192578816219, 7353.191148973501, 7499.925000749922, 7511.248875112445, 7845.097813751491, 7855.175206603224, 7906.920930790849, 7908.881366779618, 7915.960420197862, 7066.505344626033, 7126.714931402686, 7138.964305178441, 7168.139823221247, 7181.461390395637, 7140.0, 7142.607156606437, 7199.2440793715905, 7211.567305961659, 7215.639218038972], "unit": "score", "name": "mootools.html", "value": 4936.294182125693}, {"lowerIsBetter": false, "replicates": [325.68896703648016, 330.33767296570375, 335.34942212108524, 336.32734530938114, 339.92861499085177, 6655.771950603959, 6692.799216023521, 6707.7316907323775, 6709.127813384265, 6755.493337999651, 6666.366695163952, 6679.499037572189, 6686.197656281241, 6694.062831203635, 6709.899351509719, 4777.0, 4859.715933511244, 4869.0, 5012.849614511561, 5018.548330650241, 4966.478519755427, 5007.549320561167, 5015.799368025275, 5019.749012549376, 5021.623378246628, 4468.218061839181, 4498.437695288089, 4952.207646776516, 4961.107000739866, 4972.627052971024, 4704.576588107069, 4811.663183577151, 4890.902181956377, 4922.163232250526, 4932.0, 4205.453291072141, 4207.852725154636, 4209.852655157055, 4213.0099426634715, 4229.809658565372, 6421.8394540136405, 6479.83800404989, 6482.967585162091, 6513.120728701612, 6518.608883467007, 5876.500497457721, 5876.941230587682, 5877.706114694291, 5879.412058794086, 5887.85093440891, 6813.386795188457, 7157.821054473628, 7161.57030578167, 7168.641567921583, 7171.641417929082, 4086.9986853220853, 4479.4176757021705, 4568.520305367955, 4594.862154135381, 4629.074185162981, 7484.962575187144, 7582.924170758277, 7583.81040473987, 7596.65815038319, 7617.847643047108, 4647.0, 4666.160091183619, 4679.532046795293, 4680.7191568506, 4680.765961701902, 4734.881627959328, 4738.0, 4740.691855029412, 4741.359916411309, 4755.2153894607, 5500.6424582402815, 5683.556070889557, 5693.459121383462, 5699.5725320600295, 5706.25818643582, 7078.469114816409, 7177.1746249182015, 7187.353138217585, 7210.242924492957, 7213.242609525924, 1585.2232406120918, 1620.1332287226278, 1643.9725171767645, 1645.2185212024192, 1646.3990643415307, 907.6233363154217, 979.2704435195825, 1013.159077965287, 1031.8400647899587, 1060.713607326033, 6638.302978187317, 6765.424938880152, 6775.966120169368, 6782.321767823277, 6790.456763458911, 7493.0, 7493.587852668155, 7499.287567681062, 7506.924930750732, 7509.66206520697, 6753.15585551806, 6757.161991963387, 6762.425193858478, 6763.004913550416, 6772.830679233059, 3788.734788564774, 3912.0024393779404, 3958.7624742514963, 3960.2871483133313, 3961.544422391404, 6915.478594709156, 7503.062117235346, 7814.3748500119855, 7839.33365663925, 7854.410919181084, 7629.771106866803, 7691.153973062958, 7700.306972372401, 7703.768886933401, 7704.114026886868, 7804.297613214838, 7810.218978102258, 7813.609319534001, 7825.804354891174, 7834.529928204326, 7128.358447739728, 7390.076240469942, 7434.145073316421, 7442.888356674763, 7485.139208991036, 7264.418846492163, 7301.233370496021, 7303.196648368781, 7309.853802923805, 7330.963345183453, 7795.025621797276, 7796.9220307796195, 7799.337056350274, 7799.610019499116, 7807.375409967302, 4678.555537223959, 4681.555252251031, 4683.297505374221, 4688.695234809727, 4692.765361731831, 7086.681099350439, 7403.481756277009, 7415.258474152757, 7425.806903031748, 7465.365443937326, 7154.141503019671, 7182.174049984319, 7186.24544422849, 7204.783856484314, 7209.891851622335, 7167.3907717842485, 7176.318249766264, 7179.317964793337, 7184.712611495482, 7189.209186989531, 6986.790396288119, 7015.158181018311, 7016.859662806817, 7024.473164512579, 7027.6837542309695, 6123.663198524124, 6761.797146085625, 6795.38841504267, 7105.076340075964, 7174.856502870018, 6714.294999025032, 6858.5199036067, 6912.965435172792, 6956.304369563003, 7055.541389809851], "unit": "score", "name": "prototype.html", "value": 5227.498052158608}, {"lowerIsBetter": false, "replicates": [630.2909227119491, 696.9581825090495, 712.5368510468195, 762.5196126440342, 766.1572270502448, 17891.642167156664, 18282.360117395892, 18287.54281142972, 18319.816801831978, 18342.72485912709, 16431.507054788344, 16475.340986360563, 16543.172841357915, 16560.503184904443, 16594.66810663789, 748.0126233371951, 757.8332766791325, 932.9020452852454, 935.8268720286769, 949.7910459698855, 948.5020364308724, 953.4898829126419, 953.8140062687779, 953.9141477267044, 954.3271993244746, 1003.8243307421172, 1006.3961623026199, 1009.8384258518638, 1009.9546968887204, 1012.3116280928965, 797.2943944609004, 989.2432289298621, 998.181491177235, 1002.1531805624236, 1002.6390499420203, 743.2344684974485, 743.8028922335585, 744.326384621918, 746.6490749347798, 746.9589172595505, 15607.375704971788, 15615.687686246325, 15621.843781562153, 15627.062376257461, 15638.374465021385, 11187.32876027441, 12935.159214651017, 13207.405666744924, 13236.801447978289, 13492.325383730775, 10072.597096116147, 10200.387976721346, 10263.7434064149, 10623.84064239037, 11017.724556886062, 3560.3413368526903, 3589.5154154189113, 3604.8017359045243, 3666.5416822897137, 3711.3319602471543, 86517.13482865154, 88335.55832220797, 88503.0, 88555.0, 88618.99999999936, 9746.0, 9781.706548803548, 9998.300118991601, 10001.24990625706, 10149.594016239416, 22409.775902241094, 22615.208467703553, 22622.701686679477, 22630.207942722256, 22667.0, 7402.888956665654, 7544.132424771112, 7563.810904727426, 7614.771556853303, 7735.613219339123, 3993.2612466693754, 4062.4921884764403, 4070.1656160487028, 4138.958610413918, 4204.054087830214, 3666.2667466506805, 3689.2252626948643, 3699.6300369962787, 3710.6474884885893, 3711.350513660099, 569.5187566506296, 630.5586089737202, 644.1722386733026, 653.6404977262487, 655.3970347280418, 566.9092945128842, 582.5252419278274, 591.5504216795181, 592.6977241606811, 605.3976293587908, 7898.249666281809, 8302.875456868152, 8344.749657510285, 8381.07808141104, 8501.33082980855, 577.255340610616, 578.3320265093823, 585.9619124756878, 607.5929127484596, 621.6425555305717, 3834.0989867381145, 3888.475055867478, 3930.0960779020984, 3992.540857801332, 4070.271367934109, 90641.64037539442, 92124.0, 92664.0, 92727.0, 92850.0, 79681.0, 79962.6001869987, 80502.59748701337, 80610.0, 81543.18456815474, 60870.0, 60886.695566521885, 62039.6898015507, 62207.6889615549, 63483.36516634867, 7824.334931530883, 7867.498943075323, 7922.762317130495, 7938.825165102446, 7940.126586075643, 38620.03449913775, 47660.76169619129, 49056.75471622619, 49279.08452659542, 50306.496935031646, 61590.384096158465, 62629.0, 65811.0, 66124.0, 67784.0, 10227.43749093807, 10309.845352319871, 10378.844317335397, 10689.09142722846, 10950.890491094988, 11055.889441105486, 11085.889141108486, 11422.086233101165, 11448.026917712088, 11472.88527114718, 10464.215183861088, 10761.139108871428, 10762.892371076188, 10790.0, 10863.67408977732, 10353.9482302588, 10425.374477531372, 10443.738906527398, 10549.630762923261, 11067.889321107008, 10040.849387259343, 10134.645287414905, 10426.68719938403, 10444.947775261075, 10879.0, 8726.3330517319, 8827.0, 8903.06517815646, 8925.330600204881, 9142.817143657223, 6801.897971530332, 8880.0, 8937.240334571634, 8970.327225458248, 9078.682246121354], "unit": "score", "name": "yui.html", "value": 6931.726293739624}], "name": "dromaeo_css", "value": 7532.607930707489}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 112.0, 111.0, 111.0, 115.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 146.0, 156.0, 114.0, 144.0, 139.0, 122.0, 170.0, 147.0], "unit": "score", "name": "audio-beat-detection", "value": 141.5}, {"lowerIsBetter": true, "replicates": [186.0, 183.0, 186.0, 186.0, 183.0, 185.0, 188.0, 184.0, 181.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 84.0, 77.0, 56.0, 57.0, 57.0, 79.0, 76.0, 54.0], "unit": "score", "name": "audio-fft", "value": 68.8}, {"lowerIsBetter": true, "replicates": [95.0, 91.0, 130.0, 80.0, 83.0, 85.0, 115.0, 106.0, 114.0, 124.0], "unit": "score", "name": "audio-oscillator", "value": 102.3}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 85.0, 83.0, 86.0, 83.0, 86.0, 84.0, 85.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 92.0, 93.0, 92.0, 92.0, 105.0, 148.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 99.2}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 87.0, 85.0, 83.0, 90.0, 84.0, 85.0, 84.0, 82.0], "unit": "score", "name": "imaging-desaturate", "value": 84.9}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 53.0, 53.0, 52.0, 54.0, 56.0, 63.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.7}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 66.0, 73.0, 69.0, 67.0, 67.0, 66.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 106.0, 83.0, 83.0, 81.0, 81.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [132.0, 127.0, 131.0, 123.0, 120.0, 120.0, 119.0, 126.0, 124.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 137.0, 138.0, 138.0, 126.0, 138.0, 135.0, 136.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.9}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 66.0, 68.0, 66.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1415.7000000000003}]} 00:46:12 INFO - Return code: 0 00:46:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:46:12 ERROR - # TBPL SUCCESS # 00:46:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:46:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:46:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:46:12 INFO - 2016-03-10 00:46:12.821 screenresolution[1678:9546] starting screenresolution argv=screenresolution get 00:46:12 INFO - 2016-03-10 00:46:12.824 screenresolution[1678:9546] Display 0: 1600x1200x32@60 00:46:12 INFO - 2016-03-10 00:46:12.830 screenresolution[1679:9549] starting screenresolution argv=screenresolution list 00:46:12 INFO - Available Modes on Display 0 00:46:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:46:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:46:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:46:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:46:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:46:13 INFO - Intel Iris: 00:46:13 INFO - Chipset Model: Intel Iris 00:46:13 INFO - Type: GPU 00:46:13 INFO - Bus: Built-In 00:46:13 INFO - VRAM (Dynamic, Max): 1536 MB 00:46:13 INFO - Vendor: Intel (0x8086) 00:46:13 INFO - Device ID: 0x0a2e 00:46:13 INFO - Revision ID: 0x0009 00:46:13 INFO - Displays: 00:46:13 INFO - Display: 00:46:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:46:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:46:13 INFO - Display Serial Number: 1600x1200 60 00:46:13 INFO - Main Display: Yes 00:46:13 INFO - Mirror: Off 00:46:13 INFO - Online: Yes 00:46:13 INFO - Rotation: Supported 00:46:13 INFO - Return code: 0 00:46:13 INFO - Running post-action listener: _resource_record_post_action 00:46:13 INFO - Running post-run listener: _resource_record_post_run 00:46:14 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 39028224; Write bytes: 702382592; Read time: 434; Write time: 1997 00:46:14 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384817664; Write bytes: 378734592; Read time: 28601; Write time: 696 00:46:14 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 38073856; Write bytes: 298826240; Read time: 419; Write time: 1248 00:46:14 INFO - Running post-run listener: _upload_blobber_files 00:46:14 INFO - Blob upload gear active. 00:46:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:46:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:46:14 INFO - (blobuploader) - INFO - Open directory for files ... 00:46:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:46:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:46:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:46:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:46:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:46:15 INFO - (blobuploader) - INFO - Done attempting. 00:46:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:46:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:46:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:46:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:46:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:46:17 INFO - (blobuploader) - INFO - Done attempting. 00:46:17 INFO - (blobuploader) - INFO - Iteration through files over. 00:46:17 INFO - Return code: 0 00:46:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:46:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:46:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ecf6238fafe5029d57ec0d37e0bdbddebda550df6bbe15f8b4a807728d612de30aa98f8ae363c1a89164a9c82ae59596dd716cbf6ffbd97ccbaea3a3d4c6407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a9f8c5c2511ae957ae0fa4f71ab58901e5b358e2e18fd00ab5633305a6bceeb08b9ff6fb663fb41dbb339ad23e22201b862ffda128a8896bfcb88fd934db79c"} 00:46:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:46:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:46:17 INFO - Contents: 00:46:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ecf6238fafe5029d57ec0d37e0bdbddebda550df6bbe15f8b4a807728d612de30aa98f8ae363c1a89164a9c82ae59596dd716cbf6ffbd97ccbaea3a3d4c6407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a9f8c5c2511ae957ae0fa4f71ab58901e5b358e2e18fd00ab5633305a6bceeb08b9ff6fb663fb41dbb339ad23e22201b862ffda128a8896bfcb88fd934db79c"} 00:46:17 INFO - Running post-run listener: copy_logs_to_upload_dir 00:46:17 INFO - Copying logs to upload dir... 00:46:17 INFO - mkdir: /builds/slave/test/build/upload/logs 00:46:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.916123 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-10 00:46:17.387902) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 00:46:17.392289) ========= 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.daiMr2COte/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.jZfynUqwKg/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ecf6238fafe5029d57ec0d37e0bdbddebda550df6bbe15f8b4a807728d612de30aa98f8ae363c1a89164a9c82ae59596dd716cbf6ffbd97ccbaea3a3d4c6407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a9f8c5c2511ae957ae0fa4f71ab58901e5b358e2e18fd00ab5633305a6bceeb08b9ff6fb663fb41dbb339ad23e22201b862ffda128a8896bfcb88fd934db79c"} build_url:https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011035 build_url: 'https://queue.taskcluster.net/v1/task/IzQMq-DmQXaGk3o8DkXcAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ecf6238fafe5029d57ec0d37e0bdbddebda550df6bbe15f8b4a807728d612de30aa98f8ae363c1a89164a9c82ae59596dd716cbf6ffbd97ccbaea3a3d4c6407", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a9f8c5c2511ae957ae0fa4f71ab58901e5b358e2e18fd00ab5633305a6bceeb08b9ff6fb663fb41dbb339ad23e22201b862ffda128a8896bfcb88fd934db79c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 00:46:17.425291) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 00:46:17.425602) ========= 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.daiMr2COte/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.jZfynUqwKg/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005000 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 00:46:17.476917) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 00:46:17.477257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 00:46:17.477649) ========= ========= Total master_lag: 0.57 =========