builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0009 starttime: 1460030741.89 results: success (0) buildid: 20160407044324 builduid: eabb0c1c2bb14eb69aa9669014db4fd1 revision: 2355485d9a8e09c7cfe47063bd192b72ec34d286 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.887764) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.888233) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.888539) ========= 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.4ffahpi3M4/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.9yjNNfbU44/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005714 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.915591) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.918914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.935851) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.936235) ========= 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.4ffahpi3M4/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.9yjNNfbU44/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005267 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.988761) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.989123) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.989498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.989819) ========= 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.4ffahpi3M4/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.9yjNNfbU44/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-07 05:05:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-04-07 05:05:42 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124534 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:42.196236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:42.196566) ========= 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.4ffahpi3M4/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.9yjNNfbU44/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.020239 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:42.233013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 05:05:42.233381) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2355485d9a8e09c7cfe47063bd192b72ec34d286 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2355485d9a8e09c7cfe47063bd192b72ec34d286 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4ffahpi3M4/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.9yjNNfbU44/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-07 05:05:42,319 truncating revision to first 12 chars 2016-04-07 05:05:42,320 Setting DEBUG logging. 2016-04-07 05:05:42,320 attempt 1/10 2016-04-07 05:05:42,320 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2355485d9a8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 05:05:43,526 unpacking tar archive at: mozilla-aurora-2355485d9a8e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.459232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 05:05:43.715196) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:43.715551) ========= echo 2355485d9a8e09c7cfe47063bd192b72ec34d286 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2355485d9a8e09c7cfe47063bd192b72ec34d286'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4ffahpi3M4/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.9yjNNfbU44/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 2355485d9a8e09c7cfe47063bd192b72ec34d286 program finished with exit code 0 elapsedTime=0.005024 script_repo_revision: '2355485d9a8e09c7cfe47063bd192b72ec34d286' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:43.766661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:43.766985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:43.783142) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-07 05:05:43.783436) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4ffahpi3M4/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.9yjNNfbU44/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:05:43 INFO - MultiFileLogger online at 20160407 05:05:43 in /builds/slave/test 05:05:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:05:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:43 INFO - {'append_to_log': False, 05:05:43 INFO - 'base_work_dir': '/builds/slave/test', 05:05:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:05:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:43 INFO - 'branch': 'Mozilla-Aurora', 05:05:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:43 INFO - 'config_files': ('talos/mac_config.py',), 05:05:43 INFO - 'default_actions': ('clobber', 05:05:43 INFO - 'read-buildbot-config', 05:05:43 INFO - 'download-and-extract', 05:05:43 INFO - 'populate-webroot', 05:05:43 INFO - 'create-virtualenv', 05:05:43 INFO - 'install', 05:05:43 INFO - 'run-tests'), 05:05:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:43 INFO - 'download_minidump_stackwalk': True, 05:05:43 INFO - 'download_symbols': 'ondemand', 05:05:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:05:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:05:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:05:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:05:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:43 INFO - 'installer_path': 'installer.exe', 05:05:43 INFO - 'log_level': 'info', 05:05:43 INFO - 'log_name': 'talos', 05:05:43 INFO - 'log_to_console': True, 05:05:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:05:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:05:43 INFO - 'opt_config_files': (), 05:05:43 INFO - 'pip_index': False, 05:05:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:05:43 INFO - 'cmd': ('bash', 05:05:43 INFO - '-c', 05:05:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:05:43 INFO - 'enabled': True, 05:05:43 INFO - 'halt_on_failure': False, 05:05:43 INFO - 'name': 'check_screen_resolution'},), 05:05:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:05:43 INFO - 'cmd': ('bash', 05:05:43 INFO - '-c', 05:05:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:05:43 INFO - 'enabled': True, 05:05:43 INFO - 'halt_on_failure': False, 05:05:43 INFO - 'name': 'check_screen_resolution'},), 05:05:43 INFO - 'run_cmd_checks_enabled': True, 05:05:43 INFO - 'sps_profile': False, 05:05:43 INFO - 'sps_profile_interval': 0, 05:05:43 INFO - 'suite': 'dromaeojs-e10s', 05:05:43 INFO - 'system_bits': '32', 05:05:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:43 INFO - 'title': 't-yosemite-r7-0009', 05:05:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:43 INFO - 'use_talos_json': True, 05:05:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:43 INFO - 'work_dir': 'build'} 05:05:43 INFO - ##### 05:05:43 INFO - ##### Running clobber step. 05:05:43 INFO - ##### 05:05:43 INFO - Running pre-action listener: _resource_record_pre_action 05:05:43 INFO - Running main action method: clobber 05:05:43 INFO - rmtree: /builds/slave/test/build 05:05:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:45 INFO - Running post-action listener: _resource_record_post_action 05:05:45 INFO - ##### 05:05:45 INFO - ##### Running read-buildbot-config step. 05:05:45 INFO - ##### 05:05:45 INFO - Running pre-action listener: _resource_record_pre_action 05:05:45 INFO - Running main action method: read_buildbot_config 05:05:45 INFO - Using buildbot properties: 05:05:45 INFO - { 05:05:45 INFO - "project": "", 05:05:45 INFO - "product": "firefox", 05:05:45 INFO - "script_repo_revision": "production", 05:05:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 05:05:45 INFO - "repository": "", 05:05:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 05:05:45 INFO - "buildid": "20160407044324", 05:05:45 INFO - "stage_platform": "macosx64", 05:05:45 INFO - "basedir": "/builds/slave/test", 05:05:45 INFO - "buildnumber": 237, 05:05:45 INFO - "platform": "yosemite_r7", 05:05:45 INFO - "mozci_request": { 05:05:45 INFO - "priority": -1, 05:05:45 INFO - "type": "trigger_all_talos_jobs", 05:05:45 INFO - "times": 6 05:05:45 INFO - }, 05:05:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:05:45 INFO - "slavebuilddir": "test", 05:05:45 INFO - "branch": "mozilla-aurora", 05:05:45 INFO - "revision": "2355485d9a8e09c7cfe47063bd192b72ec34d286", 05:05:45 INFO - "slavename": "t-yosemite-r7-0009", 05:05:45 INFO - "builduid": "eabb0c1c2bb14eb69aa9669014db4fd1", 05:05:45 INFO - "repo_path": "releases/mozilla-aurora" 05:05:45 INFO - } 05:05:45 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg. 05:05:45 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json. 05:05:45 INFO - Running post-action listener: _resource_record_post_action 05:05:45 INFO - ##### 05:05:45 INFO - ##### Running download-and-extract step. 05:05:45 INFO - ##### 05:05:45 INFO - Running pre-action listener: _resource_record_pre_action 05:05:45 INFO - Running main action method: download_and_extract 05:05:45 INFO - mkdir: /builds/slave/test/build/tests 05:05: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')]} 05:05:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json 05:05:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 05:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 05:05:45 INFO - Downloaded 1277 bytes. 05:05:45 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 05:05:45 INFO - Using the following test package requirements: 05:05:45 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:05:45 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:45 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 05:05:45 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:45 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 05:05:45 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:45 INFO - u'jsshell-mac.zip'], 05:05:45 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:45 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 05:05:45 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:05:45 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:45 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 05:05:45 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:45 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 05:05:45 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:45 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 05:05:45 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:05:45 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:45 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 05:05:45 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:05: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')]} 05:05:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip 05:05:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:05:46 INFO - Downloaded 17904082 bytes. 05:05:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:05:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:05:49 INFO - Return code: 0 05:05:49 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip 05:05:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:05:49 INFO - Downloaded 17904082 bytes. 05:05:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:05:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:05:52 INFO - Return code: 0 05:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:52 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.talos.tests.zip 05:05:52 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 05:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:05:53 INFO - Downloaded 10845168 bytes. 05:05:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:05:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:05:53 INFO - Return code: 0 05:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg 05:05:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 05:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 05:05:54 INFO - Downloaded 115185382 bytes. 05:05:54 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg 05:05:54 INFO - mkdir: /builds/slave/test/properties 05:05:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:54 INFO - Contents: 05:05:54 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg 05:05:54 INFO - Running post-action listener: _resource_record_post_action 05:05:54 INFO - Running post-action listener: set_extra_try_arguments 05:05:54 INFO - ##### 05:05:54 INFO - ##### Running populate-webroot step. 05:05:54 INFO - ##### 05:05:54 INFO - Running pre-action listener: _resource_record_pre_action 05:05:54 INFO - Running main action method: populate_webroot 05:05:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:05:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:05:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:05:54 INFO - '--tppagecycles', 05:05:54 INFO - '7'], 05:05:54 INFO - 'tests': ['tsvgm']}}, 05:05:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:05:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:05:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:05:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:05:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:05:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:05:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:54 INFO - 'talos_options': ['--e10s'], 05:05:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:54 INFO - 'tests': ['damp', 'tps']}, 05:05:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:54 INFO - 'talos_options': ['--e10s'], 05:05:54 INFO - 'tests': ['damp', 'tps']}, 05:05:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:05:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:54 INFO - 'other': {'tests': ['a11yr', 05:05:54 INFO - 'ts_paint', 05:05:54 INFO - 'tpaint', 05:05:54 INFO - 'sessionrestore', 05:05:54 INFO - 'sessionrestore_no_auto_restore', 05:05:54 INFO - 'tabpaint']}, 05:05:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:05:54 INFO - 'tests': ['a11yr', 05:05:54 INFO - 'ts_paint', 05:05:54 INFO - 'tpaint', 05:05:54 INFO - 'sessionrestore', 05:05:54 INFO - 'sessionrestore_no_auto_restore', 05:05:54 INFO - 'tabpaint']}, 05:05:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:05:54 INFO - 'tests': ['a11yr', 05:05:54 INFO - 'ts_paint', 05:05:54 INFO - 'tpaint', 05:05:54 INFO - 'sessionrestore', 05:05:54 INFO - 'sessionrestore_no_auto_restore', 05:05:54 INFO - 'tabpaint']}, 05:05:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:05:54 INFO - 'tests': ['a11yr', 05:05:54 INFO - 'ts_paint', 05:05:54 INFO - 'tpaint', 05:05:54 INFO - 'sessionrestore', 05:05:54 INFO - 'sessionrestore_no_auto_restore', 05:05:54 INFO - 'tabpaint']}, 05:05:54 INFO - 'other_l64': {'tests': ['a11yr', 05:05:54 INFO - 'ts_paint', 05:05:54 INFO - 'tpaint', 05:05:54 INFO - 'sessionrestore', 05:05:54 INFO - 'sessionrestore_no_auto_restore', 05:05:54 INFO - 'tabpaint']}, 05:05:54 INFO - 'other_nol64': {'tests': ['a11yr', 05:05:54 INFO - 'ts_paint', 05:05:54 INFO - 'tpaint', 05:05:54 INFO - 'sessionrestore', 05:05:54 INFO - 'sessionrestore_no_auto_restore', 05:05:54 INFO - 'tabpaint']}, 05:05:54 INFO - 'svgr': {'tests': ['tsvgx', 05:05:54 INFO - 'tsvgr_opacity', 05:05:54 INFO - 'tart', 05:05:54 INFO - 'tscrollx', 05:05:54 INFO - 'cart']}, 05:05:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:05:54 INFO - 'tests': ['tsvgx', 05:05:54 INFO - 'tsvgr_opacity', 05:05:54 INFO - 'tart', 05:05:54 INFO - 'tscrollx', 05:05:54 INFO - 'cart']}, 05:05:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:54 INFO - 'tests': ['tp5o']}, 05:05:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:54 INFO - 'talos_options': ['--e10s'], 05:05:54 INFO - 'tests': ['tp5o']}, 05:05:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:54 INFO - 'talos_options': ['--xperf_path', 05:05:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:54 INFO - 'tests': ['tp5n']}, 05:05:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:54 INFO - 'talos_options': ['--e10s', 05:05:54 INFO - '--xperf_path', 05:05:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:54 INFO - 'tests': ['tp5n']}}, 05:05:54 INFO - 'talos.zip': {'path': '', 05:05:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:05:54 INFO - Running post-action listener: _resource_record_post_action 05:05:54 INFO - ##### 05:05:54 INFO - ##### Running create-virtualenv step. 05:05:54 INFO - ##### 05:05:54 INFO - Running pre-action listener: _resource_record_pre_action 05:05:54 INFO - Running main action method: create_virtualenv 05:05:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:05:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:54 INFO - Using real prefix '/tools/python27' 05:05:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:58 INFO - Installing pip.................done. 05:05:58 INFO - Return code: 0 05:05:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b85af700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc31d30>, '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 0x10ba95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc28b20>, '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.4ffahpi3M4/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.9yjNNfbU44/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:05:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ffahpi3M4/Render', 05:05:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:58 INFO - 'HOME': '/Users/cltbld', 05:05:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:58 INFO - 'LOGNAME': 'cltbld', 05:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:58 INFO - 'MOZ_NO_REMOTE': '1', 05:05:58 INFO - 'NO_EM_RESTART': '1', 05:05:58 INFO - 'PAGER': '/bin/cat', 05:05:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:58 INFO - 'PWD': '/builds/slave/test', 05:05:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:58 INFO - 'SHELL': '/bin/bash', 05:05:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yjNNfbU44/Listeners', 05:05:58 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 05:05:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:58 INFO - 'USER': 'cltbld', 05:05:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:58 INFO - 'XPC_FLAGS': '0x0', 05:05:58 INFO - 'XPC_SERVICE_NAME': '0', 05:05:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:05:58 INFO - Cleaning up... 05:05:58 INFO - Return code: 0 05:05:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bd8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b85af700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc31d30>, '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 0x10ba95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc28b20>, '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.4ffahpi3M4/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.9yjNNfbU44/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:05:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ffahpi3M4/Render', 05:05:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:58 INFO - 'HOME': '/Users/cltbld', 05:05:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:58 INFO - 'LOGNAME': 'cltbld', 05:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:58 INFO - 'MOZ_NO_REMOTE': '1', 05:05:58 INFO - 'NO_EM_RESTART': '1', 05:05:58 INFO - 'PAGER': '/bin/cat', 05:05:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:58 INFO - 'PWD': '/builds/slave/test', 05:05:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:58 INFO - 'SHELL': '/bin/bash', 05:05:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yjNNfbU44/Listeners', 05:05:58 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 05:05:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:58 INFO - 'USER': 'cltbld', 05:05:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:58 INFO - 'XPC_FLAGS': '0x0', 05:05:58 INFO - 'XPC_SERVICE_NAME': '0', 05:05:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:58 INFO - Downloading/unpacking psutil>=0.7.1 05:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:01 INFO - Installing collected packages: psutil 05:06:01 INFO - Running setup.py install for psutil 05:06:01 INFO - building 'psutil._psutil_osx' extension 05:06:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:06:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:06:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:06:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:06:02 INFO - building 'psutil._psutil_posix' extension 05:06:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:06:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:06:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:06:02 INFO - ^ 05:06:02 INFO - 1 warning generated. 05:06:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:06:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:02 INFO - Successfully installed psutil 05:06:02 INFO - Cleaning up... 05:06:02 INFO - Return code: 0 05:06:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:02 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 0x10bd8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b85af700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc31d30>, '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 0x10ba95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc28b20>, '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.4ffahpi3M4/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.9yjNNfbU44/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ffahpi3M4/Render', 05:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:02 INFO - 'HOME': '/Users/cltbld', 05:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:02 INFO - 'LOGNAME': 'cltbld', 05:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:02 INFO - 'MOZ_NO_REMOTE': '1', 05:06:02 INFO - 'NO_EM_RESTART': '1', 05:06:02 INFO - 'PAGER': '/bin/cat', 05:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:02 INFO - 'PWD': '/builds/slave/test', 05:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:02 INFO - 'SHELL': '/bin/bash', 05:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yjNNfbU44/Listeners', 05:06:02 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 05:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:02 INFO - 'USER': 'cltbld', 05:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:02 INFO - 'XPC_FLAGS': '0x0', 05:06:02 INFO - 'XPC_SERVICE_NAME': '0', 05:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:06:05 INFO - Installing collected packages: mozsystemmonitor 05:06:05 INFO - Running setup.py install for mozsystemmonitor 05:06:05 INFO - Successfully installed mozsystemmonitor 05:06:05 INFO - Cleaning up... 05:06:05 INFO - Return code: 0 05:06:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:05 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 0x10bd8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b85af700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc31d30>, '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 0x10ba95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc28b20>, '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.4ffahpi3M4/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.9yjNNfbU44/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ffahpi3M4/Render', 05:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:05 INFO - 'HOME': '/Users/cltbld', 05:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:05 INFO - 'LOGNAME': 'cltbld', 05:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:05 INFO - 'MOZ_NO_REMOTE': '1', 05:06:05 INFO - 'NO_EM_RESTART': '1', 05:06:05 INFO - 'PAGER': '/bin/cat', 05:06:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:05 INFO - 'PWD': '/builds/slave/test', 05:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:05 INFO - 'SHELL': '/bin/bash', 05:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yjNNfbU44/Listeners', 05:06:05 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 05:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:05 INFO - 'USER': 'cltbld', 05:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:05 INFO - 'XPC_FLAGS': '0x0', 05:06:05 INFO - 'XPC_SERVICE_NAME': '0', 05:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:09 INFO - Downloading docopt-0.6.1.tar.gz 05:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:09 INFO - Running setup.py install for blobuploader 05:06:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:09 INFO - Running setup.py install for requests 05:06:09 INFO - Running setup.py install for docopt 05:06:10 INFO - Successfully installed blobuploader requests docopt 05:06:10 INFO - Cleaning up... 05:06:10 INFO - Return code: 0 05:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 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 0x10bd8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b85af700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc31d30>, '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 0x10ba95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc28b20>, '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.4ffahpi3M4/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.9yjNNfbU44/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:06:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ffahpi3M4/Render', 05:06:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:10 INFO - 'HOME': '/Users/cltbld', 05:06:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:10 INFO - 'LOGNAME': 'cltbld', 05:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:10 INFO - 'MOZ_NO_REMOTE': '1', 05:06:10 INFO - 'NO_EM_RESTART': '1', 05:06:10 INFO - 'PAGER': '/bin/cat', 05:06:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:10 INFO - 'PWD': '/builds/slave/test', 05:06:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:10 INFO - 'SHELL': '/bin/bash', 05:06:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yjNNfbU44/Listeners', 05:06:10 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 05:06:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:10 INFO - 'USER': 'cltbld', 05:06:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:10 INFO - 'XPC_FLAGS': '0x0', 05:06:10 INFO - 'XPC_SERVICE_NAME': '0', 05:06:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-h12hID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ej0jZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-csEdJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-wIf1Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-8qDMXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:10 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-JAxKoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-LtJP9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-WEdecY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-zhqmWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-AxWElv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-07zhYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-YNzHRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-VYMqlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-qQFZSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:11 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-roHtEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:12 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-dJXndP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:12 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-aswBbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:12 INFO - Running setup.py install for manifestparser 05:06:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:12 INFO - Running setup.py install for mozcrash 05:06:12 INFO - Running setup.py install for mozdebug 05:06:12 INFO - Running setup.py install for mozdevice 05:06:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:12 INFO - Running setup.py install for mozfile 05:06:12 INFO - Running setup.py install for mozhttpd 05:06:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Running setup.py install for mozinfo 05:06:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Running setup.py install for mozInstall 05:06:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Running setup.py install for mozleak 05:06:13 INFO - Running setup.py install for mozlog 05:06:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Running setup.py install for moznetwork 05:06:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:13 INFO - Running setup.py install for mozprocess 05:06:13 INFO - Running setup.py install for mozprofile 05:06:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:14 INFO - Running setup.py install for mozrunner 05:06:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:14 INFO - Running setup.py install for mozscreenshot 05:06:14 INFO - Running setup.py install for moztest 05:06:14 INFO - Running setup.py install for mozversion 05:06:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:14 INFO - Cleaning up... 05:06:14 INFO - Return code: 0 05:06:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:14 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 0x10bd8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b85af700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc31d30>, '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 0x10ba95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc28b20>, '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.4ffahpi3M4/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.9yjNNfbU44/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:06:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ffahpi3M4/Render', 05:06:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:14 INFO - 'HOME': '/Users/cltbld', 05:06:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:14 INFO - 'LOGNAME': 'cltbld', 05:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:14 INFO - 'MOZ_NO_REMOTE': '1', 05:06:14 INFO - 'NO_EM_RESTART': '1', 05:06:14 INFO - 'PAGER': '/bin/cat', 05:06:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:14 INFO - 'PWD': '/builds/slave/test', 05:06:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:14 INFO - 'SHELL': '/bin/bash', 05:06:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yjNNfbU44/Listeners', 05:06:14 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 05:06:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:14 INFO - 'USER': 'cltbld', 05:06:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:14 INFO - 'XPC_FLAGS': '0x0', 05:06:14 INFO - 'XPC_SERVICE_NAME': '0', 05:06:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Bu4aVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-CA8LTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-qOQ6WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-eZDs0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-KggwmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-CR95lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-LwVclG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-QjPYPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-hBJ9rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:15 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-bFw9Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-DolCQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-6Gy7uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-1HxTXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-8FPJIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-f3ls89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-7ccbja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:16 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-irjo1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:19 INFO - Downloading blessings-1.6.tar.gz 05:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:19 INFO - Installing collected packages: blessings 05:06:19 INFO - Running setup.py install for blessings 05:06:19 INFO - Successfully installed blessings 05:06:19 INFO - Cleaning up... 05:06:19 INFO - Return code: 0 05:06:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:19 INFO - Reading from file tmpfile_stdout 05:06:19 INFO - Current package versions: 05:06:19 INFO - blessings == 1.6 05:06:19 INFO - blobuploader == 1.2.4 05:06:19 INFO - docopt == 0.6.1 05:06:19 INFO - manifestparser == 1.1 05:06:19 INFO - mozInstall == 1.12 05:06:19 INFO - mozcrash == 0.17 05:06:19 INFO - mozdebug == 0.1 05:06:19 INFO - mozdevice == 0.48 05:06:19 INFO - mozfile == 1.2 05:06:19 INFO - mozhttpd == 0.7 05:06:19 INFO - mozinfo == 0.9 05:06:19 INFO - mozleak == 0.1 05:06:19 INFO - mozlog == 3.1 05:06:19 INFO - moznetwork == 0.27 05:06:19 INFO - mozprocess == 0.22 05:06:19 INFO - mozprofile == 0.28 05:06:19 INFO - mozrunner == 6.11 05:06:19 INFO - mozscreenshot == 0.1 05:06:19 INFO - mozsystemmonitor == 0.0 05:06:19 INFO - moztest == 0.7 05:06:19 INFO - mozversion == 1.4 05:06:19 INFO - psutil == 3.1.1 05:06:19 INFO - requests == 1.2.3 05:06:19 INFO - wsgiref == 0.1.2 05:06:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:19 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 0x10bd8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b85af700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc31d30>, '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 0x10ba95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc28b20>, '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.4ffahpi3M4/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.9yjNNfbU44/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ffahpi3M4/Render', 05:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:19 INFO - 'HOME': '/Users/cltbld', 05:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:19 INFO - 'LOGNAME': 'cltbld', 05:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:19 INFO - 'MOZ_NO_REMOTE': '1', 05:06:19 INFO - 'NO_EM_RESTART': '1', 05:06:19 INFO - 'PAGER': '/bin/cat', 05:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:19 INFO - 'PWD': '/builds/slave/test', 05:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:19 INFO - 'SHELL': '/bin/bash', 05:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yjNNfbU44/Listeners', 05:06:19 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 05:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:19 INFO - 'USER': 'cltbld', 05:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:19 INFO - 'XPC_FLAGS': '0x0', 05:06:19 INFO - 'XPC_SERVICE_NAME': '0', 05:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:06:20 INFO - Cleaning up... 05:06:20 INFO - Return code: 0 05:06:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:20 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 0x10bd8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b85af700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc31d30>, '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 0x10ba95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc28b20>, '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.4ffahpi3M4/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.9yjNNfbU44/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:06:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ffahpi3M4/Render', 05:06:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:20 INFO - 'HOME': '/Users/cltbld', 05:06:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:20 INFO - 'LOGNAME': 'cltbld', 05:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:20 INFO - 'MOZ_NO_REMOTE': '1', 05:06:20 INFO - 'NO_EM_RESTART': '1', 05:06:20 INFO - 'PAGER': '/bin/cat', 05:06:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:20 INFO - 'PWD': '/builds/slave/test', 05:06:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:20 INFO - 'SHELL': '/bin/bash', 05:06:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yjNNfbU44/Listeners', 05:06:20 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 05:06:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:20 INFO - 'USER': 'cltbld', 05:06:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:20 INFO - 'XPC_FLAGS': '0x0', 05:06:20 INFO - 'XPC_SERVICE_NAME': '0', 05:06:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:20 INFO - Downloading/unpacking jsonschema 05:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:22 INFO - Downloading/unpacking functools32 (from jsonschema) 05:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:23 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:23 INFO - warning: no files found matching '*.txt' 05:06:23 INFO - no previously-included directories found matching 'build' 05:06:23 INFO - no previously-included directories found matching 'dist' 05:06:23 INFO - no previously-included directories found matching '.git*' 05:06:23 INFO - Installing collected packages: jsonschema, functools32 05:06:23 INFO - Running setup.py install for functools32 05:06:23 INFO - warning: no files found matching '*.txt' 05:06:23 INFO - no previously-included directories found matching 'build' 05:06:23 INFO - no previously-included directories found matching 'dist' 05:06:23 INFO - no previously-included directories found matching '.git*' 05:06:23 INFO - Successfully installed jsonschema functools32 05:06:23 INFO - Cleaning up... 05:06:23 INFO - Return code: 0 05:06:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd8da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd944c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4b85af700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc31d30>, '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 0x10ba95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc28b20>, '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.4ffahpi3M4/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.9yjNNfbU44/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ffahpi3M4/Render', 05:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:23 INFO - 'HOME': '/Users/cltbld', 05:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:23 INFO - 'LOGNAME': 'cltbld', 05:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:23 INFO - 'MOZ_NO_REMOTE': '1', 05:06:23 INFO - 'NO_EM_RESTART': '1', 05:06:23 INFO - 'PAGER': '/bin/cat', 05:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:23 INFO - 'PWD': '/builds/slave/test', 05:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:23 INFO - 'SHELL': '/bin/bash', 05:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yjNNfbU44/Listeners', 05:06:23 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 05:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:23 INFO - 'USER': 'cltbld', 05:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:23 INFO - 'XPC_FLAGS': '0x0', 05:06:23 INFO - 'XPC_SERVICE_NAME': '0', 05:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:23 INFO - Downloading/unpacking flake8 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:06:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:06:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:06:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:27 INFO - no previously-included directories found matching 'docs/_build' 05:06:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:06:27 INFO - Running setup.py install for pep8 05:06:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:27 INFO - no previously-included directories found matching 'docs/_build' 05:06:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:06:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:06:27 INFO - Cleaning up... 05:06:27 INFO - Return code: 0 05:06:27 INFO - Running post-action listener: _resource_record_post_action 05:06:27 INFO - Running post-action listener: _start_resource_monitoring 05:06:27 INFO - Starting resource monitoring. 05:06:27 INFO - ##### 05:06:27 INFO - ##### Running install step. 05:06:27 INFO - ##### 05:06:27 INFO - Running pre-action listener: _resource_record_pre_action 05:06:27 INFO - Running main action method: install 05:06:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:28 INFO - Reading from file tmpfile_stdout 05:06:28 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:28 INFO - Reading from file tmpfile_stdout 05:06:28 INFO - Output received: 05:06:28 INFO - Usage: mozinstall [options] installer 05:06:28 INFO - Options: 05:06:28 INFO - -h, --help show this help message and exit 05:06:28 INFO - -d DEST, --destination=DEST 05:06:28 INFO - Directory to install application into. [default: 05:06:28 INFO - "/builds/slave/test"] 05:06:28 INFO - --app=APP Application being installed. [default: firefox] 05:06:28 INFO - mkdir: /builds/slave/test/build/application 05:06:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:07:00 INFO - Reading from file tmpfile_stdout 05:07:00 INFO - Output received: 05:07:00 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:07:00 INFO - Running post-action listener: _resource_record_post_action 05:07:00 INFO - ##### 05:07:00 INFO - ##### Running run-tests step. 05:07:00 INFO - ##### 05:07:00 INFO - Running pre-action listener: _resource_record_pre_action 05:07:00 INFO - Running main action method: run_tests 05:07:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:07:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:07:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:07:00 INFO - 2016-04-07 05:07:00.731 screenresolution[1949:20528] starting screenresolution argv=screenresolution get 05:07:00 INFO - 2016-04-07 05:07:00.734 screenresolution[1949:20528] Display 0: 1600x1200x32@60 05:07:00 INFO - 2016-04-07 05:07:00.740 screenresolution[1950:20530] starting screenresolution argv=screenresolution list 05:07:00 INFO - Available Modes on Display 0 05:07:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:07:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:07:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:07:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:07:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:07:00 INFO - Intel Iris: 05:07:00 INFO - Chipset Model: Intel Iris 05:07:00 INFO - Type: GPU 05:07:00 INFO - Bus: Built-In 05:07:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:07:00 INFO - Vendor: Intel (0x8086) 05:07:00 INFO - Device ID: 0x0a2e 05:07:00 INFO - Revision ID: 0x0009 05:07:00 INFO - Displays: 05:07:00 INFO - Display: 05:07:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:07:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:07:00 INFO - Display Serial Number: 1600x1200 60 05:07:00 INFO - Main Display: Yes 05:07:00 INFO - Mirror: Off 05:07:00 INFO - Online: Yes 05:07:00 INFO - Rotation: Supported 05:07:00 INFO - Return code: 0 05:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:00 INFO - Python 2.7.3 05:07:00 INFO - Return code: 0 05:07:00 INFO - grabbing minidump binary from tooltool 05:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:00 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 0x10bc31d30>, '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 0x10ba95db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc28b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:07:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:07:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:01 INFO - Return code: 0 05:07:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:07:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:07:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:07:02 INFO - Return code: 0 05:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:07:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4ffahpi3M4/Render', 05:07:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:02 INFO - 'HOME': '/Users/cltbld', 05:07:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:02 INFO - 'LOGNAME': 'cltbld', 05:07:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:02 INFO - 'MOZ_NO_REMOTE': '1', 05:07:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:02 INFO - 'NO_EM_RESTART': '1', 05:07:02 INFO - 'PAGER': '/bin/cat', 05:07:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:02 INFO - 'PWD': '/builds/slave/test', 05:07:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:02 INFO - 'SHELL': '/bin/bash', 05:07:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9yjNNfbU44/Listeners', 05:07:02 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 05:07:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:02 INFO - 'USER': 'cltbld', 05:07:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:02 INFO - 'XPC_FLAGS': '0x0', 05:07:02 INFO - 'XPC_SERVICE_NAME': '0', 05:07:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:07:02 INFO - mozversion application_buildid: 20160406205952 05:07:02 INFO - mozversion application_changeset: 2355485d9a8e09c7cfe47063bd192b72ec34d286 05:07:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:07:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:02 INFO - mozversion application_name: Firefox 05:07:02 INFO - mozversion application_remotingname: firefox-dev 05:07:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:07:02 INFO - mozversion application_vendor: Mozilla 05:07:02 INFO - mozversion application_version: 47.0a2 05:07:02 INFO - mozversion platform_buildid: 20160406205952 05:07:02 INFO - mozversion platform_changeset: 2355485d9a8e09c7cfe47063bd192b72ec34d286 05:07:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:07:02 INFO - mozversion platform_version: 47.0a2 05:07:02 INFO - using testdate: 1460030822 05:07:02 INFO - actual date: 1460030822 05:07:02 INFO - starting webserver on 'localhost:56706' 05:07:02 INFO - SUITE-START | Running 2 tests 05:07:02 INFO - TEST-START | dromaeo_css 05:07:02 INFO - operating with platform_type : mac_ 05:07:02 INFO - Initialising browser for dromaeo_css test... 05:07:02 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpemweDm/profile http://localhost:56706/getInfo.html) 05:07:05 INFO - PROCESS | 1968 | __metrics Screen width/height:1600/1200 05:07:05 INFO - PROCESS | 1968 | colorDepth:24 05:07:05 INFO - PROCESS | 1968 | Browser inner width/height: 1024/689 05:07:05 INFO - PROCESS | 1968 | __metrics 05:07:05 ERROR - PROCESS | 1968 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:07:05 INFO - TEST-INFO | 1968: exit 0 05:07:05 INFO - Browser initialized. 05:07:05 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:05 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpemweDm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:17 INFO - PROCESS | 1971 | RSS: Main: 217927680 05:07:17 INFO - PROCESS | 1971 | 05:08:07 INFO - PROCESS | 1971 | 1460030887267 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:10:17 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:56706/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56706/tests/dromaeo/cssquery-ext.html) 05:10:19 INFO - PROCESS | 1971 | RSS: Main: 228831232 05:10:19 INFO - PROCESS | 1971 | 05:13:21 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:56706/tests/dromaeo/cssquery-ext.html (next: http://localhost:56706/tests/dromaeo/cssquery-jquery.html) 05:13:21 INFO - PROCESS | 1971 | RSS: Main: 240451584 05:13:21 INFO - PROCESS | 1971 | 05:16:23 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:56706/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56706/tests/dromaeo/cssquery-mootools.html) 05:16:24 INFO - PROCESS | 1971 | RSS: Main: 242601984 05:16:24 INFO - PROCESS | 1971 | 05:19:25 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:56706/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56706/tests/dromaeo/cssquery-prototype.html) 05:19:26 INFO - PROCESS | 1971 | RSS: Main: 244391936 05:19:26 INFO - PROCESS | 1971 | 05:22:29 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:56706/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56706/tests/dromaeo/cssquery-yui.html) 05:22:29 INFO - PROCESS | 1971 | RSS: Main: 247361536 05:22:29 INFO - PROCESS | 1971 | 05:25:31 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:56706/tests/dromaeo/cssquery-yui.html (next: http://localhost:56706/tests/dromaeo/cssquery-dojo.html) 05:25:32 INFO - PROCESS | 1971 | RSS: Main: 248139776 05:25:32 INFO - PROCESS | 1971 | 05:25:32 INFO - PROCESS | 1971 | __start_tp_report 05:25:32 INFO - PROCESS | 1971 | _x_x_mozilla_page_load 05:25:32 INFO - PROCESS | 1971 | _x_x_mozilla_page_load_details 05:25:32 INFO - PROCESS | 1971 | |i|pagename|runs| 05:25:32 INFO - PROCESS | 1971 | |0;dojo.html;3121.84390780461;3536.3811333016724;3572.535570375851;3625.619309972453;3628.782273063618;5888.205092312547;5969.164316995613;5971.88056238876;5988.431099045589;5994.640321580709;5340.732963351827;5631.493165615094;5949.70251487425;5953.940460595392;5995.760169593222;5277.551408130304;5300.893982120355;5348.705821179834;5364.7317634118335;5368.516833484986;4845.3216549683075;5268.104422248208;5284.973575132119;5380.91928621071;5381.246625472437;5363.436839131893;5395.325584301962;5396.676199428027;5408.621396502246;5414.539764120054;4427.53510881356;4449.7330160190495;4602.941323495581;5308.787648494075;5340.706261155635;5162.45794191612;5184.818531351422;5187.144121220032;5261.158214685632;5280.339957505312;5658.943410565883;5823.767049318022;5829.271341082364;5858.150568167634;5870.73581688825;6169.7532098716;6170.2904166021035;6233.781817636406;6239.2824825145235;6244.469220116295;6162.414570615784;6218.657973811439;6220.1602783624085;6234.750609975596;6291.182146320994;5985.790497332572;5993.793320573473;5999.850003749854;6003;6056.031035034417;5468.398476167618;6360.300366959631;6389.9680501597195;6392.744290228339;6411.3909178627955;5047.192449208183;6123.496151642696;6137.683438940261;6220.688965551704;6238.532110091761;6238.906416403757;6252.624842509464;6257.937420625826;6260.467860231931;6273.592216505913;5254.448282930313;6165.599236049642;6195.039768835838;6218.626882387071;6221.688915554295;6183.783567575113;6193.628382297076;6230.719617617218;6230.909590821588;6233.189685340967;4957.281194226817;4995.550400463976;5030.019146266516;5035.546800787946;5051.368578927634;4390.407295015196;4433.401490798701;4553.33976573395;4554.612857907049;4562.520935301745;5939.881202375928;5971.850703732354;6016.578839481282;6053.394660534;6112.724927378279;6272.466840318532;6295.527835412271;6322.430981211713;6325.430711236011;6342.302346741854;5891.558133140032;6029.668368239789;6045.21412216409;6062.211912451441;6066.272047354346;4650.534946505322;5516.91724624131;5537.36320323168;5540.085885828874;5548.945700316927;6454.935450645434;6458.6770661466735;6471.773487927994;6520.836979075466;6528.608283503005;6174.073888916699;6244.531660125418;6266.968665156645;6284.905726414016;6294.748210071729;6437.742490300336;6509.7396104155305;6519.608823470607;6529.020646903003;6563.638999854863;6178.845528861634;6217.720202590985;6244.1570387997035;6248.031555108965;6256.405641464054;6170.444659980623;6170.629762214281;6209.59637623553;6280;6288.654124023223;5226.980738756059;6140.258857967636;6194.845128871814;6201.844953876189;6209.2548894133;5489.725513724218;6200.193974783249;6204.906926396198;6208.565400421927;6227.190465239671;6031.125486804301;6062.333143354139;6109.829807539466;6124.47247923558;6146.200993870768;6179.104029915727;6194.4115309045565;6195.977663685441;6217.844553886189;6244.219472565929;6080.939190608037;6093.9085913712215;6099.932511810327;6119.051547010221;6447.645379503984 05:25:32 INFO - PROCESS | 1971 | |1;ext.html;439.78890132736285;465.0536158916605;548.88199037207;591.8106206014075;609.0559632569519;37919.62080379196;38762;38770.41844372336;38833.25250363733;38937.805310973476;37117.814410927975;39647.60352396475;40066.198676026535;40184.59815401845;40287;9452.19656329213;9678.612855485771;9691.321607487478;9711.951440242789;9719;9583.945765965738;9781.119699227069;9811.803763924752;9813.116819486244;9861.260405469582;9749.756256093584;9774.120329170373;9814.558344874462;9826.066523680274;9850.113489785917;9701.27240456965;9782.168515676176;9789.21686265097;9829.950850245703;9834.606615735398;9579.904200957972;9689;9731.513424328827;9749;9775.853362199572;39117.41323880144;39367.40948885769;39486;39599.60400395988;39737.20525589472;2496.4757400945823;3108.937821243585;3148.3231105312466;3291.555639988595;3308.8180150091735;26966;27088.83289336868;27214.45571088567;27857.58213626797;27878.3030424239;2690.784737221037;2725.1824452664123;2744.0670172141567;2761.792865535093;2786.5541513357766;254795;322765;323619;326918;338079;58390.41609583935;62842.68578657169;62899.37100629027;62968.68515657484;63125.684371577845;75928;76086.6195669018;76854.23145768582;77035;77133.61433192798;18073.909630451762;18104.90947545254;18196.363127290482;18269.81730182708;18318.633627327377;13620.727585448434;13905.374258158407;13950.651233719238;13991.580252592235;14040.508582199574;21940.89029554842;22116.557668846533;22210.44473888166;22247.77637229968;22778.43053923665;9330.906690933003;9529.618815247313;9531.618735250651;9540.61837526505;9546.904530954602;1010.3331801011298;1031.339942436841;1039.835384369511;1128.8588926384202;1191.803352446854;29062;29898.953536626115;29948.70051299459;30221.395572088873;30281.850943639616;959.822432849925;1139.8518192634904;1163.4880652512868;1180.3626041937257;1231.2612432540404;14239.78640320396;14435.639109022148;14641.780373294408;14742.557723268319;14743.631409214855;493699;497930.0206997956;498179;498695;498864;58285;58828;58983.70508147432;59025.70487147623;59980.70009649924;1379.717157982611;1384.9238291893842;1542.2134711297094;1554.1374537132;1581.7943667323404;25395.857186427023;27810;27928.860355698092;28438.57342139911;28707.569386459636;48125.03749925052;48288.758556206994;48497;48544.75727621339;48785.268220976;380946;398170;464741;464984;469650;34631.30737385188;35021.124471888405;35045.299094017464;37002.81498592597;45762.54237457716;44316;44404;47188.05623887434;48788.75605621949;48931.26603101027;31300.217494562818;36481.81759091187;36714.4492832613;36794;37772.62227377691;32109.518357225126;36983.44524832076;37053.25893482169;37398.252034959696;37554.812225938695;37972.62027379691;38528.614713853625;39759.204815902944;40000.19999599933;40123.398149027205;30075;31923.84038079795;31978.52032219472;32008.83995580007;32106.678933211304;24529.50940981206;24532;24806.751932480445;24975.375615609755;24977.75022249827 05:25:32 INFO - PROCESS | 1971 | |2;jquery.html;364.1660597232338;367.74258019386417;368.74188068352163;375.78955784760535;376.8454933477275;18618.69669123162;20504;21035.47411314718;21671.6749248761;21770.12919483223;21007.789922100776;21338.89330553349;21345.25291614794;21610.351689449304;21620.567588648217;5768.192453056576;6031.939680603182;6055.091736239555;6055.515558755311;6056.788012419566;4864.221724524077;5831.329397119322;5877.471027607515;5928.1404196391495;5933.3473317934995;5119.820806271781;5867.794627188049;5877.324107727623;5879.000569903105;5883.970580147115;5582.609217354787;5839.0949402842625;5866.442687944638;5868.325142608591;5880.206172166745;5064.215046667772;5087.084324821531;5099.33708617881;5115.923261151086;5118.4625614310335;25910.611340829902;26097.217083487525;26404.47191056187;26589.803458844206;26890.865545672343;2126.128287402173;2332.5334933013296;2923.619929409163;2932.5161348377706;2934.2517657997287;14623.78064329036;14788.926055369655;14915.179665118414;14975.700485990219;15223.923880380638;1694.3984885365765;1759.498542915263;1802;1817.3366721146817;1832.569346203641;100441.995580044;101497.99999999926;102718.48640756749;103000;104740;10599.258051936291;10914.672559823219;10993.186124289403;11027.944860275808;11218.887811121947;13137.34313284332;13227.470901163846;13242.470301187845;13311.467541298432;13320.267385293902;8748.256398206096;8763.649454021896;8789.692360767342;8855.848739663803;8940.105989401009;9220.5850736717;9264.95367523158;9278.907210927939;9299.442033478013;9380.343375963754;5199.922001169985;5562.833115006556;5761.222234998306;6281.59169653971;6301.40136687014;1630.5623093475094;1697.5840918974684;1717.3559915031863;1869.224271927135;1875.8499320054364;930.8277968575835;1003.9308136834248;1076.8101248120713;1106.7122548137381;1129.6444266879778;18624.906875465535;21563.35309940673;21645.783542164376;21995.450113747283;22074.558508829734;1019.4851599942131;1129.6611016694958;1133.167122165208;1141.452102990569;1145.919785614999;11478.426078696199;11894.64316070502;11930.88069119315;11947.462364193632;11979.341136237415;595052;601077;608758;621173;621293.467663312;105126.47436762767;106026.46986765017;106561.46719266353;109705.45147274212;110634.44682776695;1012.1801340913884;1109.046220250584;1121.0863146535548;1132.3828513460185;1132.7451323452158;19206.423807285802;19414.320498782476;19447.61104777925;19493.61012779708;19505.51236219049;38336.80831595824;49115.75442122766;49872.50127498679;50242;50332.74833625808;67686.91565521184;68706;69151;70581;70813.64593177;7985.361171106414;8119.391045671717;8176.46852954556;8204.753857384288;8220.219079187467;13364.665883352995;13511.86488135106;13573.52492662752;13795.10331828428;13966.860331396556;9035.373632745906;9746.658866939906;11895.881041189477;11972.521099155936;12081.214721043105;10030.398176109456;11453.713657158638;11493.827592586285;11998.580049698568;12052.975497082496;11443.885561144281;11771.823422648838;11953.043756499634;12050.578229761917;12080.154389192672;7963.442559021045;7986.241307075818;8066.1127275998415;8204.220599043081;8347.582620869054;8482.287456958364;11653.76692466129;11789.469473873525;11820.349880756641;11968.640940771791 05:25:32 INFO - PROCESS | 1971 | |3;mootools.html;1675.1540472061608;1680.1095419427706;2047.9590408191837;2076.5360420903257;2133.9786602133972;6974;8930.59812308446;9048.954755226232;9233.676821311265;9263.675771348004;8960.238379737713;8972.820543589125;9037.909620903805;9065.546722663858;9086.04596517366;2545.2873195505194;2566.4995325911455;2569.6274040264243;2570.9228723138335;2583.1346498922885;2502.2368177705794;2556.0542599238306;2560.2703229579574;2560.590305551112;2560.987195064022;2128.19128731082;2252.31304452142;2407.241718858554;2464.9400757674193;2615.0847203478725;2531.063506502587;2533.7972962162985;2561.8462892226435;2563.4104156044214;2567.7047139579;1997.590493948737;2504.4365017871014;2556.9360765980814;2561.705403878559;2595.6755405574304;9121;9148.725538233864;9170.174684278447;9171.037041110721;9178.586963586655;4878.292647566083;5589.217509548666;5764.74058667361;5765.365809760923;5796.333421656522;3605.801680907549;3705.314516814398;3723.7579557328686;3745.756525825813;3745.9625403745886;936.391345625349;1038.8857225705167;1077.6928575355985;1078.9406582637953;1078.9892101078967;12294.815577766341;12365.629031129081;12405.44175512104;12421.813672794915;12434.818692224315;4970.627202959792;5004.099262132779;5032.949670503322;5092.185250359925;5092.770825312869;10495.685129446128;10538.367697938149;10566.947165264124;10575.36547807134;10583;5665.348484924204;5667.631603945731;5692.316921969307;5730.713464326767;5771.538276937835;4241.406203131564;4588.334691469719;5099.847004589868;5105.974470127626;5121.820736274287;4131.628153466202;4168.7707176105;4179.728317659343;4186.434831297796;4200.138971510833;1343.0397265954693;1363.584106847421;1371.245814801875;1375.8899288056932;1380.8412032616177;1176.5764324843221;1179.8820117988305;1189.4290740444635;1200.477792160413;1215.8297838302644;8445;8489.193526614961;8506.064332923374;8522.147785221552;8597.355198360148;1282.160185078775;1286.8906142977764;1294.7022184897526;1311.1739604049387;1344.2606566388447;6492.350764923564;6516.6415847128865;6532.902006469907;6593.7362505500205;6608.7356505739235;10626.426073353678;11244.66266012021;11268.436578171058;11412.600558980395;11417.143714221467;10804.567817287221;10956.780864382827;11016.504257308441;11103.333799972028;11298.305254211935;8678.86981695275;8773.517456539952;8810.427322224035;8819.911800882037;8897.466152030898;8179.836403271782;8233.50598964064;8259.504429734236;8300.377471689526;8322.126176751353;9696.5151742414;9958.302918795614;9963.202943764627;9985.900140998498;10015.048570385801;10168.542415591464;10405.47972601382;10408.635697750542;10530.315529490865;10583.682489525327;6531.836704082246;7305.2329505403295;7363.705451782083;7366.410687145123;7408.518446300973;8684.088170742234;8687.826243475221;8698.086700896567;8745.78135546591;8793.988691300583;7582.545047296959;7774.183710710294;7801.726939557088;7803.609819508888;7859;7105.893411598727;7124;7131.893021604784;7265.600391978492;7276.599787011765;8091.797705057421;8119.106898241307;8123.106458289465;8141.145179756278;8147.959260203661;7249.963750181215;7292.562446253241;7335.926640733524;7339;7357.558546487228;6742.988551717282;6879.5184337095925;7270.854582908418;7318.121825380776;7324.816879578053 05:25:32 INFO - PROCESS | 1971 | |4;prototype.html;281.81963543332273;287.5844404835013;329.1606403670641;335.0467918771095;335.7381242630749;6802.693878775454;6875.071865298183;6929.203141638713;6963.79108626742;7019.333163349486;6829;6855.657217139148;6871.55334903231;6875.862482750342;6891.173059232887;4731.124741922756;4868.415790105192;4958.305837182797;5009.348784658007;5061.797528098871;3668.8899333020054;4997.575206107467;5048.6970781753025;5056.671316364443;5070.74646267687;4961.454240033593;4997.375328083989;5003.649744517885;5007.848194915154;5042.067217564744;5004.049230646202;5005.224190250517;5012.448630650625;5029.5221953914315;5030.723310217936;4261.978690106561;4263.829446822155;4270.12462445198;4279.465066866642;4281.7002809803325;5384.757685904144;6390.680465976682;6584.308647591982;6680.86425307694;6798.422134118606;5882.6764527950945;5948.464638182584;5953.642781433128;5973.432523910222;6000.099985002241;6674.666266686695;7239.914012898054;7304.452166087512;7348.853022939565;7362.7423040193335;4787.16224660683;4801.399825021872;4814.927776083362;4817.7591120444185;4820.686655367425;7784.961075194645;7818.569978651172;7829.29536341732;7831.216878312181;7856.096548896893;4531.886702832389;4741.596964258077;4764.547368000034;4767.594754445911;4768.809247630125;4799.088173247072;4841.927371089437;4858.659893807399;4864;4866.878328041827;5054.21659642756;5806.88386232273;5853.356130825691;5885.175595565388;5886.646801191942;7447.1063472382575;7448.329650331496;7461.141968673672;7464.962675186589;7473.476856620093;1659.775930249425;1672.2140593920838;1672.5818545363659;1673.3724853180058;1684.8904821186584;1021.213665477578;1058.9629362972414;1059.5484186664319;1064.1486810551528;1075.7687097273968;6853.554518956252;6875.1749790025515;6913.89629155563;6918.0314755934205;6918.515703900679;6229.221347331583;7561.357284630868;7619.123800762873;7634.160242373335;7670.232976702285;6746.392824645805;6822.3859852613505;6887.966804979193;6898.758543450955;6946.16646002483;4045.5752146024242;4082.4284600156;4100.425940368351;4116.58834116586;4123.154753275571;8164.877526837102;8173.918260817434;8177.713780017671;8193.426460147852;8213.79465513355;7813.413993950477;7998.040235171817;8039.155888631726;8055.315298199719;8063.4355595108955;6587.089743974289;8101.918980810352;8119.431639785276;8133.959330203311;8180.222878826502;6858.417034552119;7196.10048743907;7791.181925897699;7794.2985131338455;7806.765797026098;7583.469157158946;7593.962030189814;7619.08570971487;7621.1616722161625;7622.733204337822;7926.128125906261;8126;8139.308158806568;8202.138775428493;8223.753287401149;4758.952410475851;4811.230203167476;4822.132016237111;4826.8793280168275;4829.1790395633525;6620.768273110418;7768.300852923264;7786.649600767866;7792.025996750406;7808.102068262223;7460.3658689012045;7495.025646665898;7497.512661676974;7513.173550909505;7526.811829704301;7096.148462184365;7351.044364232615;7416.888746668912;7467.2532746727065;7518.699252029857;7212.4590655699985;7257.237990010973;7285.635718214174;7286.344229019413;7297.562146271241;6172.475339596184;7437.107547094383;7442.809150535888;7464.440166987389;7467.514611550232;5905.730267992402;7262.96368518154;7278.490505664553;7288.635568221674;7339.449541284532 05:25:32 INFO - PROCESS | 1971 | |5;yui.html;706.777365129984;707.8018154916625;745.5899255409527;765.2577000309701;799.344537479267;14820.592043755853;15120.621984450381;15164.469243576477;15195.772063419045;17747.201375938082;16896.324147034135;16967;16983.320667173328;16997.320107195726;17057;795.6578671171394;963.1139351796329;983.1986930651532;989.1246247071358;989.6635144051021;985.6008316631776;986.4328011393477;987.8221920054388;990.7126933189367;990.9405435673847;1048.3238311289215;1048.6853943816864;1049.7480604654866;1049.837275222338;1052.384355152233;1027.850961610566;1038.382162613244;1039.3192458939368;1040.0379648824808;1040.5889673578895;770.1335997003371;771.5139462138873;773.9690412383497;776.996115019427;779.9142094369615;15755.369785208577;15972.920135399365;16205.91897040519;16219.756703649455;16240.269187886573;12746.171498852545;12857.45513801388;12909.967202623768;12924.741505169937;12978.221306721627;10026.037799360443;10215.795684086352;10306.175505959505;10312.381257124596;10383.688489345332;3659.963400365989;4154.31453810121;4221.78891055446;4353.41228934093;4374.650027997753;65849.67075164641;77582.61208693977;78748.21251787523;78904.60547697225;79238.60380698118;9787.657431989846;9883.950580247196;9983.051610097029;10101;10260.794784104277;22469.550608987727;22469.66295505536;22636;23452.179173728837;23936.760632393452;7879.699849524764;7937.722179723797;7944.642491087915;8039.554167456633;8098.271155596025;3947.7236593438756;4140.296149654566;4276.764777937181;4282.935755963663;4331.805068771912;3781.0736369589076;3821.121142137268;3842.1355195080882;3842.346801043829;3849.3263678856088;669.0532895952173;675.2572170612287;679.0730652659084;688.707299397764;689.1076056506836;590.1825971030069;599.310792588518;600.8828278485653;611.9077446757517;623.2365352443221;7311.159216690043;7500.36246919018;8094.392920530984;8192.959035204905;8394.160583941557;460.7721665746155;545.9890802183934;547.7316115103571;594.7154147042454;595.2232336800516;3630.4735813306925;3744.1949980753725;3782.6406491383273;3784.829682664287;3955.624215699504;84904.15095849086;86756.56621716851;87512;88538.55730721305;89184.6622300666;76909.61545192238;77498.6125069371;77711.22288777152;80056.59971700104;80418;63161.684191578745;63982.6800866002;65851.01223481652;66464.33535664678;66754;7325.120985481776;7512.436567257587;7646.388288936983;7780.533168009937;7988.600569971594;41489.96275093147;45930.770346149395;49976.75011624918;50474.99050019053;52184;63076.05385919307;69158.65420672865;70403;70543;71500.64249678719;10324.48377581133;10522.053015228359;10569.207309451667;10591.152707783205;10807.837882431613;10613.522391492246;10622.468876555986;10697.625583104555;10722.678319650424;11015.008649221609;10241.283110182514;10412.167026637699;10441;10488.213383996079;10544.84182737275;10093.596256149673;10125;10170.745731356776;10202.540885660015;10380.532876020749;9787.21702263803;10057.943915888727;10143.391396516232;10373.118284945562;10478.685639430829;8423.284020858297;8423.32613390915;8568.828623427622;8599.312055035707;8780.121987801169;7530.277784685826;8738.126187381211;8844;8863.556822158995;9198.172164505228 05:25:32 INFO - PROCESS | 1971 | __end_tp_report 05:25:32 INFO - PROCESS | 1971 | __start_cc_report 05:25:32 INFO - PROCESS | 1971 | _x_x_mozilla_cycle_collect,365 05:25:32 INFO - PROCESS | 1971 | __end_cc_report 05:25:32 INFO - PROCESS | 1971 | __startTimestamp1460031932223__endTimestamp 05:25:32 INFO - PROCESS | 1971 | 05:25:32 INFO - PROCESS | 1971 | ------- Summary: start ------- 05:25:32 INFO - PROCESS | 1971 | Number of tests: 6 05:25:32 INFO - PROCESS | 1971 | 05:25:32 INFO - PROCESS | 1971 | [#0] dojo.html Cycles:165 Average:5805.58 Median:6093.91 stddev:663.77 (10.9%) stddev-sans-first:631.53 05:25:32 INFO - PROCESS | 1971 | Values: 3121.8 3536.4 3572.5 3625.6 3628.8 5888.2 5969.2 5971.9 5988.4 5994.6 5340.7 5631.5 5949.7 5953.9 5995.8 5277.6 5300.9 5348.7 5364.7 5368.5 4845.3 5268.1 5285.0 5380.9 5381.2 5363.4 5395.3 5396.7 5408.6 5414.5 4427.5 4449.7 4602.9 5308.8 5340.7 5162.5 5184.8 5187.1 5261.2 5280.3 5658.9 5823.8 5829.3 5858.2 5870.7 6169.8 6170.3 6233.8 6239.3 6244.5 6162.4 6218.7 6220.2 6234.8 6291.2 5985.8 5993.8 5999.9 6003.0 6056.0 5468.4 6360.3 6390.0 6392.7 6411.4 5047.2 6123.5 6137.7 6220.7 6238.5 6238.9 6252.6 6257.9 6260.5 6273.6 5254.4 6165.6 6195.0 6218.6 6221.7 6183.8 6193.6 6230.7 6230.9 6233.2 4957.3 4995.6 5030.0 5035.5 5051.4 4390.4 4433.4 4553.3 4554.6 4562.5 5939.9 5971.9 6016.6 6053.4 6112.7 6272.5 6295.5 6322.4 6325.4 6342.3 5891.6 6029.7 6045.2 6062.2 6066.3 4650.5 5516.9 5537.4 5540.1 5548.9 6454.9 6458.7 6471.8 6520.8 6528.6 6174.1 6244.5 6267.0 6284.9 6294.7 6437.7 6509.7 6519.6 6529.0 6563.6 6178.8 6217.7 6244.2 6248.0 6256.4 6170.4 6170.6 6209.6 6280.0 6288.7 5227.0 6140.3 6194.8 6201.8 6209.3 5489.7 6200.2 6204.9 6208.6 6227.2 6031.1 6062.3 6109.8 6124.5 6146.2 6179.1 6194.4 6196.0 6217.8 6244.2 6080.9 6093.9 6099.9 6119.1 6447.6 05:25:32 INFO - PROCESS | 1971 | 05:25:32 INFO - PROCESS | 1971 | [#1] ext.html Cycles:180 Average:57892.19 Median:209459.31 stddev:112224.52 (53.6%) stddev-sans-first:112456.44 05:25:32 INFO - PROCESS | 1971 | Values: 439.8 465.1 548.9 591.8 609.1 37919.6 38762.0 38770.4 38833.3 38937.8 37117.8 39647.6 40066.2 40184.6 40287.0 9452.2 9678.6 9691.3 9712.0 9719.0 9583.9 9781.1 9811.8 9813.1 9861.3 9749.8 9774.1 9814.6 9826.1 9850.1 9701.3 9782.2 9789.2 9830.0 9834.6 9579.9 9689.0 9731.5 9749.0 9775.9 39117.4 39367.4 39486.0 39599.6 39737.2 2496.5 3108.9 3148.3 3291.6 3308.8 26966.0 27088.8 27214.5 27857.6 27878.3 2690.8 2725.2 2744.1 2761.8 2786.6 254795.0 322765.0 323619.0 326918.0 338079.0 58390.4 62842.7 62899.4 62968.7 63125.7 75928.0 76086.6 76854.2 77035.0 77133.6 18073.9 18104.9 18196.4 18269.8 18318.6 13620.7 13905.4 13950.7 13991.6 14040.5 21940.9 22116.6 22210.4 22247.8 22778.4 9330.9 9529.6 9531.6 9540.6 9546.9 1010.3 1031.3 1039.8 1128.9 1191.8 29062.0 29899.0 29948.7 30221.4 30281.9 959.8 1139.9 1163.5 1180.4 1231.3 14239.8 14435.6 14641.8 14742.6 14743.6 493699.0 497930.0 498179.0 498695.0 498864.0 58285.0 58828.0 58983.7 59025.7 59980.7 1379.7 1384.9 1542.2 1554.1 1581.8 25395.9 27810.0 27928.9 28438.6 28707.6 48125.0 48288.8 48497.0 48544.8 48785.3 380946.0 398170.0 464741.0 464984.0 469650.0 34631.3 35021.1 35045.3 37002.8 45762.5 44316.0 44404.0 47188.1 48788.8 48931.3 31300.2 36481.8 36714.4 36794.0 37772.6 32109.5 36983.4 37053.3 37398.3 37554.8 37972.6 38528.6 39759.2 40000.2 40123.4 30075.0 31923.8 31978.5 32008.8 32106.7 24529.5 24532.0 24806.8 24975.4 24977.8 05:25:32 INFO - PROCESS | 1971 | 05:25:32 INFO - PROCESS | 1971 | [#2] jquery.html Cycles:180 Average:34274.27 Median:21615.46 stddev:100661.01 (465.7%) stddev-sans-first:100911.19 05:25:32 INFO - PROCESS | 1971 | Values: 364.2 367.7 368.7 375.8 376.8 18618.7 20504.0 21035.5 21671.7 21770.1 21007.8 21338.9 21345.3 21610.4 21620.6 5768.2 6031.9 6055.1 6055.5 6056.8 4864.2 5831.3 5877.5 5928.1 5933.3 5119.8 5867.8 5877.3 5879.0 5884.0 5582.6 5839.1 5866.4 5868.3 5880.2 5064.2 5087.1 5099.3 5115.9 5118.5 25910.6 26097.2 26404.5 26589.8 26890.9 2126.1 2332.5 2923.6 2932.5 2934.3 14623.8 14788.9 14915.2 14975.7 15223.9 1694.4 1759.5 1802.0 1817.3 1832.6 100442.0 101498.0 102718.5 103000.0 104740.0 10599.3 10914.7 10993.2 11027.9 11218.9 13137.3 13227.5 13242.5 13311.5 13320.3 8748.3 8763.6 8789.7 8855.8 8940.1 9220.6 9265.0 9278.9 9299.4 9380.3 5199.9 5562.8 5761.2 6281.6 6301.4 1630.6 1697.6 1717.4 1869.2 1875.8 930.8 1003.9 1076.8 1106.7 1129.6 18624.9 21563.4 21645.8 21995.5 22074.6 1019.5 1129.7 1133.2 1141.5 1145.9 11478.4 11894.6 11930.9 11947.5 11979.3 595052.0 601077.0 608758.0 621173.0 621293.5 105126.5 106026.5 106561.5 109705.5 110634.4 1012.2 1109.0 1121.1 1132.4 1132.7 19206.4 19414.3 19447.6 19493.6 19505.5 38336.8 49115.8 49872.5 50242.0 50332.7 67686.9 68706.0 69151.0 70581.0 70813.6 7985.4 8119.4 8176.5 8204.8 8220.2 13364.7 13511.9 13573.5 13795.1 13966.9 9035.4 9746.7 11895.9 11972.5 12081.2 10030.4 11453.7 11493.8 11998.6 12053.0 11443.9 11771.8 11953.0 12050.6 12080.2 7963.4 7986.2 8066.1 8204.2 8347.6 8482.3 11653.8 11789.5 11820.3 11968.6 05:25:32 INFO - PROCESS | 1971 | 05:25:32 INFO - PROCESS | 1971 | [#3] mootools.html Cycles:180 Average:6284.20 Median:5062.57 stddev:3319.28 (65.6%) stddev-sans-first:3310.51 05:25:32 INFO - PROCESS | 1971 | Values: 1675.2 1680.1 2048.0 2076.5 2134.0 6974.0 8930.6 9049.0 9233.7 9263.7 8960.2 8972.8 9037.9 9065.5 9086.0 2545.3 2566.5 2569.6 2570.9 2583.1 2502.2 2556.1 2560.3 2560.6 2561.0 2128.2 2252.3 2407.2 2464.9 2615.1 2531.1 2533.8 2561.8 2563.4 2567.7 1997.6 2504.4 2556.9 2561.7 2595.7 9121.0 9148.7 9170.2 9171.0 9178.6 4878.3 5589.2 5764.7 5765.4 5796.3 3605.8 3705.3 3723.8 3745.8 3746.0 936.4 1038.9 1077.7 1078.9 1079.0 12294.8 12365.6 12405.4 12421.8 12434.8 4970.6 5004.1 5032.9 5092.2 5092.8 10495.7 10538.4 10566.9 10575.4 10583.0 5665.3 5667.6 5692.3 5730.7 5771.5 4241.4 4588.3 5099.8 5106.0 5121.8 4131.6 4168.8 4179.7 4186.4 4200.1 1343.0 1363.6 1371.2 1375.9 1380.8 1176.6 1179.9 1189.4 1200.5 1215.8 8445.0 8489.2 8506.1 8522.1 8597.4 1282.2 1286.9 1294.7 1311.2 1344.3 6492.4 6516.6 6532.9 6593.7 6608.7 10626.4 11244.7 11268.4 11412.6 11417.1 10804.6 10956.8 11016.5 11103.3 11298.3 8678.9 8773.5 8810.4 8819.9 8897.5 8179.8 8233.5 8259.5 8300.4 8322.1 9696.5 9958.3 9963.2 9985.9 10015.0 10168.5 10405.5 10408.6 10530.3 10583.7 6531.8 7305.2 7363.7 7366.4 7408.5 8684.1 8687.8 8698.1 8745.8 8794.0 7582.5 7774.2 7801.7 7803.6 7859.0 7105.9 7124.0 7131.9 7265.6 7276.6 8091.8 8119.1 8123.1 8141.1 8148.0 7250.0 7292.6 7335.9 7339.0 7357.6 6743.0 6879.5 7270.9 7318.1 7324.8 05:25:32 INFO - PROCESS | 1971 | 05:25:32 INFO - PROCESS | 1971 | [#4] prototype.html Cycles:180 Average:6022.08 Median:6854.61 stddev:1970.77 (28.8%) stddev-sans-first:1928.63 05:25:32 INFO - PROCESS | 1971 | Values: 281.8 287.6 329.2 335.0 335.7 6802.7 6875.1 6929.2 6963.8 7019.3 6829.0 6855.7 6871.6 6875.9 6891.2 4731.1 4868.4 4958.3 5009.3 5061.8 3668.9 4997.6 5048.7 5056.7 5070.7 4961.5 4997.4 5003.6 5007.8 5042.1 5004.0 5005.2 5012.4 5029.5 5030.7 4262.0 4263.8 4270.1 4279.5 4281.7 5384.8 6390.7 6584.3 6680.9 6798.4 5882.7 5948.5 5953.6 5973.4 6000.1 6674.7 7239.9 7304.5 7348.9 7362.7 4787.2 4801.4 4814.9 4817.8 4820.7 7785.0 7818.6 7829.3 7831.2 7856.1 4531.9 4741.6 4764.5 4767.6 4768.8 4799.1 4841.9 4858.7 4864.0 4866.9 5054.2 5806.9 5853.4 5885.2 5886.6 7447.1 7448.3 7461.1 7465.0 7473.5 1659.8 1672.2 1672.6 1673.4 1684.9 1021.2 1059.0 1059.5 1064.1 1075.8 6853.6 6875.2 6913.9 6918.0 6918.5 6229.2 7561.4 7619.1 7634.2 7670.2 6746.4 6822.4 6888.0 6898.8 6946.2 4045.6 4082.4 4100.4 4116.6 4123.2 8164.9 8173.9 8177.7 8193.4 8213.8 7813.4 7998.0 8039.2 8055.3 8063.4 6587.1 8101.9 8119.4 8134.0 8180.2 6858.4 7196.1 7791.2 7794.3 7806.8 7583.5 7594.0 7619.1 7621.2 7622.7 7926.1 8126.0 8139.3 8202.1 8223.8 4759.0 4811.2 4822.1 4826.9 4829.2 6620.8 7768.3 7786.6 7792.0 7808.1 7460.4 7495.0 7497.5 7513.2 7526.8 7096.1 7351.0 7416.9 7467.3 7518.7 7212.5 7257.2 7285.6 7286.3 7297.6 6172.5 7437.1 7442.8 7464.4 7467.5 5905.7 7263.0 7278.5 7288.6 7339.4 05:25:32 INFO - PROCESS | 1971 | 05:25:32 INFO - PROCESS | 1971 | [#5] yui.html Cycles:180 Average:17919.08 Median:51329.50 stddev:24809.56 (48.3%) stddev-sans-first:24845.49 05:25:32 INFO - PROCESS | 1971 | Values: 706.8 707.8 745.6 765.3 799.3 14820.6 15120.6 15164.5 15195.8 17747.2 16896.3 16967.0 16983.3 16997.3 17057.0 795.7 963.1 983.2 989.1 989.7 985.6 986.4 987.8 990.7 990.9 1048.3 1048.7 1049.7 1049.8 1052.4 1027.9 1038.4 1039.3 1040.0 1040.6 770.1 771.5 774.0 777.0 779.9 15755.4 15972.9 16205.9 16219.8 16240.3 12746.2 12857.5 12910.0 12924.7 12978.2 10026.0 10215.8 10306.2 10312.4 10383.7 3660.0 4154.3 4221.8 4353.4 4374.7 65849.7 77582.6 78748.2 78904.6 79238.6 9787.7 9884.0 9983.1 10101.0 10260.8 22469.6 22469.7 22636.0 23452.2 23936.8 7879.7 7937.7 7944.6 8039.6 8098.3 3947.7 4140.3 4276.8 4282.9 4331.8 3781.1 3821.1 3842.1 3842.3 3849.3 669.1 675.3 679.1 688.7 689.1 590.2 599.3 600.9 611.9 623.2 7311.2 7500.4 8094.4 8193.0 8394.2 460.8 546.0 547.7 594.7 595.2 3630.5 3744.2 3782.6 3784.8 3955.6 84904.2 86756.6 87512.0 88538.6 89184.7 76909.6 77498.6 77711.2 80056.6 80418.0 63161.7 63982.7 65851.0 66464.3 66754.0 7325.1 7512.4 7646.4 7780.5 7988.6 41490.0 45930.8 49976.8 50475.0 52184.0 63076.1 69158.7 70403.0 70543.0 71500.6 10324.5 10522.1 10569.2 10591.2 10807.8 10613.5 10622.5 10697.6 10722.7 11015.0 10241.3 10412.2 10441.0 10488.2 10544.8 10093.6 10125.0 10170.7 10202.5 10380.5 9787.2 10057.9 10143.4 10373.1 10478.7 8423.3 8423.3 8568.8 8599.3 8780.1 7530.3 8738.1 8844.0 8863.6 9198.2 05:25:32 INFO - PROCESS | 1971 | -------- Summary: end -------- 05:25:32 INFO - PROCESS | 1971 | 05:25:32 INFO - TEST-INFO | 1971: exit 0 05:25:32 INFO - TEST-OK | dromaeo_css | took 1110314ms 05:25:32 INFO - TEST-START | kraken 05:25:32 INFO - operating with platform_type : mac_ 05:25:32 INFO - Initialising browser for kraken test... 05:25:32 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmplzuiUV/profile http://localhost:56706/getInfo.html) 05:25:35 INFO - PROCESS | 1975 | __metrics Screen width/height:1600/1200 05:25:35 INFO - PROCESS | 1975 | colorDepth:24 05:25:35 INFO - PROCESS | 1975 | Browser inner width/height: 1024/689 05:25:35 INFO - PROCESS | 1975 | __metrics 05:25:35 ERROR - PROCESS | 1975 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:25:36 INFO - TEST-INFO | 1975: exit 0 05:25:36 INFO - Browser initialized. 05:25:36 INFO - Running cycle 1/1 for kraken test... 05:25:36 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmplzuiUV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:48 INFO - PROCESS | 1978 | RSS: Main: 217587712 05:25:48 INFO - PROCESS | 1978 | 05:25:50 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56706/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:51 INFO - PROCESS | 1978 | RSS: Main: 229572608 05:25:51 INFO - PROCESS | 1978 | 05:25:54 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56706/tests/kraken/driver.html?testName=audio-dft) 05:25:54 INFO - PROCESS | 1978 | RSS: Main: 238555136 05:25:54 INFO - PROCESS | 1978 | 05:25:58 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56706/tests/kraken/driver.html?testName=audio-fft) 05:25:58 INFO - PROCESS | 1978 | RSS: Main: 241954816 05:25:58 INFO - PROCESS | 1978 | 05:26:00 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56706/tests/kraken/driver.html?testName=audio-oscillator) 05:26:01 INFO - PROCESS | 1978 | RSS: Main: 243642368 05:26:01 INFO - PROCESS | 1978 | 05:26:03 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56706/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:04 INFO - PROCESS | 1978 | RSS: Main: 244215808 05:26:04 INFO - PROCESS | 1978 | 05:26:06 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56706/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:07 INFO - PROCESS | 1978 | RSS: Main: 244396032 05:26:07 INFO - PROCESS | 1978 | 05:26:10 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56706/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:10 INFO - PROCESS | 1978 | RSS: Main: 244338688 05:26:10 INFO - PROCESS | 1978 | 05:26:13 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56706/tests/kraken/driver.html?testName=json-parse-financial) 05:26:14 INFO - PROCESS | 1978 | RSS: Main: 244465664 05:26:14 INFO - PROCESS | 1978 | 05:26:16 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56706/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:16 INFO - PROCESS | 1978 | RSS: Main: 244510720 05:26:16 INFO - PROCESS | 1978 | 05:26:18 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56706/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:19 INFO - PROCESS | 1978 | RSS: Main: 244453376 05:26:19 INFO - PROCESS | 1978 | 05:26:21 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56706/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:21 INFO - PROCESS | 1978 | RSS: Main: 244776960 05:26:21 INFO - PROCESS | 1978 | 05:26:24 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:25 INFO - PROCESS | 1978 | RSS: Main: 245342208 05:26:25 INFO - PROCESS | 1978 | 05:26:27 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:28 INFO - PROCESS | 1978 | RSS: Main: 245575680 05:26:28 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56706/tests/kraken/driver.html?testName=ai-astar) 05:26:30 INFO - PROCESS | 1978 | RSS: Main: 246652928 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | __start_tp_report 05:26:30 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 05:26:30 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 05:26:30 INFO - PROCESS | 1978 | |i|pagename|runs| 05:26:30 INFO - PROCESS | 1978 | |0;ai-astar;116;108;115;114;115;135;136;118;114;116 05:26:30 INFO - PROCESS | 1978 | |1;audio-beat-detection;162;131;144;154;143;168;156;119;159;131 05:26:30 INFO - PROCESS | 1978 | |2;audio-dft;201;200;201;203;229;195;194;199;202;199 05:26:30 INFO - PROCESS | 1978 | |3;audio-fft;65;74;89;109;82;82;84;84;135;57 05:26:30 INFO - PROCESS | 1978 | |4;audio-oscillator;89;87;120;66;95;121;152;89;78;120 05:26:30 INFO - PROCESS | 1978 | |5;imaging-gaussian-blur;131;91;91;124;90;85;91;87;105;111 05:26:30 INFO - PROCESS | 1978 | |6;imaging-darkroom;96;106;95;96;96;95;95;97;94;96 05:26:30 INFO - PROCESS | 1978 | |7;imaging-desaturate;97;92;140;147;129;99;93;91;125;115 05:26:30 INFO - PROCESS | 1978 | |8;json-parse-financial;56;57;59;60;59;58;59;67;58;54 05:26:30 INFO - PROCESS | 1978 | |9;json-stringify-tinderbox;64;62;72;73;79;73;71;67;66;66 05:26:30 INFO - PROCESS | 1978 | |10;stanford-crypto-aes;76;86;75;100;106;100;84;81;84;85 05:26:30 INFO - PROCESS | 1978 | |11;stanford-crypto-ccm;140;130;127;129;122;148;133;134;146;142 05:26:30 INFO - PROCESS | 1978 | |12;stanford-crypto-pbkdf2;137;139;144;152;144;139;132;137;153;166 05:26:30 INFO - PROCESS | 1978 | |13;stanford-crypto-sha256-iterative;69;75;93;92;84;57;90;63;59;76 05:26:30 INFO - PROCESS | 1978 | __end_tp_report 05:26:30 INFO - PROCESS | 1978 | __start_cc_report 05:26:30 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,956 05:26:30 INFO - PROCESS | 1978 | __end_cc_report 05:26:30 INFO - PROCESS | 1978 | __startTimestamp1460031990371__endTimestamp 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | ------- Summary: start ------- 05:26:30 INFO - PROCESS | 1978 | Number of tests: 14 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#0] ai-astar Cycles:10 Average:118.70 Median:116.00 stddev:9.23 (8.0%) stddev-sans-first:9.73 05:26:30 INFO - PROCESS | 1978 | Values: 116.0 108.0 115.0 114.0 115.0 135.0 136.0 118.0 114.0 116.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:155.00 stddev:15.85 (10.2%) stddev-sans-first:15.81 05:26:30 INFO - PROCESS | 1978 | Values: 162.0 131.0 144.0 154.0 143.0 168.0 156.0 119.0 159.0 131.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#2] audio-dft Cycles:10 Average:202.30 Median:201.00 stddev:9.81 (4.9%) stddev-sans-first:10.39 05:26:30 INFO - PROCESS | 1978 | Values: 201.0 200.0 201.0 203.0 229.0 195.0 194.0 199.0 202.0 199.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#3] audio-fft Cycles:10 Average:86.10 Median:82.00 stddev:22.12 (27.0%) stddev-sans-first:22.11 05:26:30 INFO - PROCESS | 1978 | Values: 65.0 74.0 89.0 109.0 82.0 82.0 84.0 84.0 135.0 57.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:82.50 stddev:25.80 (31.3%) stddev-sans-first:26.96 05:26:30 INFO - PROCESS | 1978 | Values: 89.0 87.0 120.0 66.0 95.0 121.0 152.0 89.0 78.0 120.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:88.50 stddev:16.39 (18.5%) stddev-sans-first:13.18 05:26:30 INFO - PROCESS | 1978 | Values: 131.0 91.0 91.0 124.0 90.0 85.0 91.0 87.0 105.0 111.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:96.00 stddev:3.41 (3.5%) stddev-sans-first:3.61 05:26:30 INFO - PROCESS | 1978 | Values: 96.0 106.0 95.0 96.0 96.0 95.0 95.0 97.0 94.0 96.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#7] imaging-desaturate Cycles:10 Average:112.80 Median:91.50 stddev:21.25 (23.2%) stddev-sans-first:21.76 05:26:30 INFO - PROCESS | 1978 | Values: 97.0 92.0 140.0 147.0 129.0 99.0 93.0 91.0 125.0 115.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.00 stddev:3.40 (5.8%) stddev-sans-first:3.46 05:26:30 INFO - PROCESS | 1978 | Values: 56.0 57.0 59.0 60.0 59.0 58.0 59.0 67.0 58.0 54.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:71.50 stddev:5.17 (7.2%) stddev-sans-first:5.11 05:26:30 INFO - PROCESS | 1978 | Values: 64.0 62.0 72.0 73.0 79.0 73.0 71.0 67.0 66.0 66.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:82.50 stddev:10.64 (12.9%) stddev-sans-first:10.40 05:26:30 INFO - PROCESS | 1978 | Values: 76.0 86.0 75.0 100.0 106.0 100.0 84.0 81.0 84.0 85.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:137.00 stddev:8.58 (6.3%) stddev-sans-first:8.92 05:26:30 INFO - PROCESS | 1978 | Values: 140.0 130.0 127.0 129.0 122.0 148.0 133.0 134.0 146.0 142.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:144.00 stddev:10.11 (7.0%) stddev-sans-first:10.37 05:26:30 INFO - PROCESS | 1978 | Values: 137.0 139.0 144.0 152.0 144.0 139.0 132.0 137.0 153.0 166.0 05:26:30 INFO - PROCESS | 1978 | 05:26:30 INFO - PROCESS | 1978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:80.00 stddev:13.64 (17.0%) stddev-sans-first:14.24 05:26:30 INFO - PROCESS | 1978 | Values: 69.0 75.0 93.0 92.0 84.0 57.0 90.0 63.0 59.0 76.0 05:26:30 INFO - PROCESS | 1978 | -------- Summary: end -------- 05:26:30 INFO - PROCESS | 1978 | 05:26:31 INFO - TEST-INFO | 1978: exit 0 05:26:31 INFO - TEST-OK | kraken | took 58368ms 05:26:31 INFO - SUITE-END | took 1168s 05:26:31 INFO - Completed test suite (00:19:29) 05:26:31 INFO - javascript benchmark 05:26:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3121.84390780461, 3536.3811333016724, 3572.535570375851, 3625.619309972453, 3628.782273063618, 5888.205092312547, 5969.164316995613, 5971.88056238876, 5988.431099045589, 5994.640321580709, 5340.732963351827, 5631.493165615094, 5949.70251487425, 5953.940460595392, 5995.760169593222, 5277.551408130304, 5300.893982120355, 5348.705821179834, 5364.7317634118335, 5368.516833484986, 4845.3216549683075, 5268.104422248208, 5284.973575132119, 5380.91928621071, 5381.246625472437, 5363.436839131893, 5395.325584301962, 5396.676199428027, 5408.621396502246, 5414.539764120054, 4427.53510881356, 4449.7330160190495, 4602.941323495581, 5308.787648494075, 5340.706261155635, 5162.45794191612, 5184.818531351422, 5187.144121220032, 5261.158214685632, 5280.339957505312, 5658.943410565883, 5823.767049318022, 5829.271341082364, 5858.150568167634, 5870.73581688825, 6169.7532098716, 6170.2904166021035, 6233.781817636406, 6239.2824825145235, 6244.469220116295, 6162.414570615784, 6218.657973811439, 6220.1602783624085, 6234.750609975596, 6291.182146320994, 5985.790497332572, 5993.793320573473, 5999.850003749854, 6003.0, 6056.031035034417, 5468.398476167618, 6360.300366959631, 6389.9680501597195, 6392.744290228339, 6411.3909178627955, 5047.192449208183, 6123.496151642696, 6137.683438940261, 6220.688965551704, 6238.532110091761, 6238.906416403757, 6252.624842509464, 6257.937420625826, 6260.467860231931, 6273.592216505913, 5254.448282930313, 6165.599236049642, 6195.039768835838, 6218.626882387071, 6221.688915554295, 6183.783567575113, 6193.628382297076, 6230.719617617218, 6230.909590821588, 6233.189685340967, 4957.281194226817, 4995.550400463976, 5030.019146266516, 5035.546800787946, 5051.368578927634, 4390.407295015196, 4433.401490798701, 4553.33976573395, 4554.612857907049, 4562.520935301745, 5939.881202375928, 5971.850703732354, 6016.578839481282, 6053.394660534, 6112.724927378279, 6272.466840318532, 6295.527835412271, 6322.430981211713, 6325.430711236011, 6342.302346741854, 5891.558133140032, 6029.668368239789, 6045.21412216409, 6062.211912451441, 6066.272047354346, 4650.534946505322, 5516.91724624131, 5537.36320323168, 5540.085885828874, 5548.945700316927, 6454.935450645434, 6458.6770661466735, 6471.773487927994, 6520.836979075466, 6528.608283503005, 6174.073888916699, 6244.531660125418, 6266.968665156645, 6284.905726414016, 6294.748210071729, 6437.742490300336, 6509.7396104155305, 6519.608823470607, 6529.020646903003, 6563.638999854863, 6178.845528861634, 6217.720202590985, 6244.1570387997035, 6248.031555108965, 6256.405641464054, 6170.444659980623, 6170.629762214281, 6209.59637623553, 6280.0, 6288.654124023223, 5226.980738756059, 6140.258857967636, 6194.845128871814, 6201.844953876189, 6209.2548894133, 5489.725513724218, 6200.193974783249, 6204.906926396198, 6208.565400421927, 6227.190465239671, 6031.125486804301, 6062.333143354139, 6109.829807539466, 6124.47247923558, 6146.200993870768, 6179.104029915727, 6194.4115309045565, 6195.977663685441, 6217.844553886189, 6244.219472565929, 6080.939190608037, 6093.9085913712215, 6099.932511810327, 6119.051547010221, 6447.645379503984], "unit": "score", "name": "dojo.html", "value": 5764.811001543319}, {"lowerIsBetter": false, "replicates": [439.78890132736285, 465.0536158916605, 548.88199037207, 591.8106206014075, 609.0559632569519, 37919.62080379196, 38762.0, 38770.41844372336, 38833.25250363733, 38937.805310973476, 37117.814410927975, 39647.60352396475, 40066.198676026535, 40184.59815401845, 40287.0, 9452.19656329213, 9678.612855485771, 9691.321607487478, 9711.951440242789, 9719.0, 9583.945765965738, 9781.119699227069, 9811.803763924752, 9813.116819486244, 9861.260405469582, 9749.756256093584, 9774.120329170373, 9814.558344874462, 9826.066523680274, 9850.113489785917, 9701.27240456965, 9782.168515676176, 9789.21686265097, 9829.950850245703, 9834.606615735398, 9579.904200957972, 9689.0, 9731.513424328827, 9749.0, 9775.853362199572, 39117.41323880144, 39367.40948885769, 39486.0, 39599.60400395988, 39737.20525589472, 2496.4757400945823, 3108.937821243585, 3148.3231105312466, 3291.555639988595, 3308.8180150091735, 26966.0, 27088.83289336868, 27214.45571088567, 27857.58213626797, 27878.3030424239, 2690.784737221037, 2725.1824452664123, 2744.0670172141567, 2761.792865535093, 2786.5541513357766, 254795.0, 322765.0, 323619.0, 326918.0, 338079.0, 58390.41609583935, 62842.68578657169, 62899.37100629027, 62968.68515657484, 63125.684371577845, 75928.0, 76086.6195669018, 76854.23145768582, 77035.0, 77133.61433192798, 18073.909630451762, 18104.90947545254, 18196.363127290482, 18269.81730182708, 18318.633627327377, 13620.727585448434, 13905.374258158407, 13950.651233719238, 13991.580252592235, 14040.508582199574, 21940.89029554842, 22116.557668846533, 22210.44473888166, 22247.77637229968, 22778.43053923665, 9330.906690933003, 9529.618815247313, 9531.618735250651, 9540.61837526505, 9546.904530954602, 1010.3331801011298, 1031.339942436841, 1039.835384369511, 1128.8588926384202, 1191.803352446854, 29062.0, 29898.953536626115, 29948.70051299459, 30221.395572088873, 30281.850943639616, 959.822432849925, 1139.8518192634904, 1163.4880652512868, 1180.3626041937257, 1231.2612432540404, 14239.78640320396, 14435.639109022148, 14641.780373294408, 14742.557723268319, 14743.631409214855, 493699.0, 497930.0206997956, 498179.0, 498695.0, 498864.0, 58285.0, 58828.0, 58983.70508147432, 59025.70487147623, 59980.70009649924, 1379.717157982611, 1384.9238291893842, 1542.2134711297094, 1554.1374537132, 1581.7943667323404, 25395.857186427023, 27810.0, 27928.860355698092, 28438.57342139911, 28707.569386459636, 48125.03749925052, 48288.758556206994, 48497.0, 48544.75727621339, 48785.268220976, 380946.0, 398170.0, 464741.0, 464984.0, 469650.0, 34631.30737385188, 35021.124471888405, 35045.299094017464, 37002.81498592597, 45762.54237457716, 44316.0, 44404.0, 47188.05623887434, 48788.75605621949, 48931.26603101027, 31300.217494562818, 36481.81759091187, 36714.4492832613, 36794.0, 37772.62227377691, 32109.518357225126, 36983.44524832076, 37053.25893482169, 37398.252034959696, 37554.812225938695, 37972.62027379691, 38528.614713853625, 39759.204815902944, 40000.19999599933, 40123.398149027205, 30075.0, 31923.84038079795, 31978.52032219472, 32008.83995580007, 32106.678933211304, 24529.50940981206, 24532.0, 24806.751932480445, 24975.375615609755, 24977.75022249827], "unit": "score", "name": "ext.html", "value": 19815.486184852434}, {"lowerIsBetter": false, "replicates": [364.1660597232338, 367.74258019386417, 368.74188068352163, 375.78955784760535, 376.8454933477275, 18618.69669123162, 20504.0, 21035.47411314718, 21671.6749248761, 21770.12919483223, 21007.789922100776, 21338.89330553349, 21345.25291614794, 21610.351689449304, 21620.567588648217, 5768.192453056576, 6031.939680603182, 6055.091736239555, 6055.515558755311, 6056.788012419566, 4864.221724524077, 5831.329397119322, 5877.471027607515, 5928.1404196391495, 5933.3473317934995, 5119.820806271781, 5867.794627188049, 5877.324107727623, 5879.000569903105, 5883.970580147115, 5582.609217354787, 5839.0949402842625, 5866.442687944638, 5868.325142608591, 5880.206172166745, 5064.215046667772, 5087.084324821531, 5099.33708617881, 5115.923261151086, 5118.4625614310335, 25910.611340829902, 26097.217083487525, 26404.47191056187, 26589.803458844206, 26890.865545672343, 2126.128287402173, 2332.5334933013296, 2923.619929409163, 2932.5161348377706, 2934.2517657997287, 14623.78064329036, 14788.926055369655, 14915.179665118414, 14975.700485990219, 15223.923880380638, 1694.3984885365765, 1759.498542915263, 1802.0, 1817.3366721146817, 1832.569346203641, 100441.995580044, 101497.99999999926, 102718.48640756749, 103000.0, 104740.0, 10599.258051936291, 10914.672559823219, 10993.186124289403, 11027.944860275808, 11218.887811121947, 13137.34313284332, 13227.470901163846, 13242.470301187845, 13311.467541298432, 13320.267385293902, 8748.256398206096, 8763.649454021896, 8789.692360767342, 8855.848739663803, 8940.105989401009, 9220.5850736717, 9264.95367523158, 9278.907210927939, 9299.442033478013, 9380.343375963754, 5199.922001169985, 5562.833115006556, 5761.222234998306, 6281.59169653971, 6301.40136687014, 1630.5623093475094, 1697.5840918974684, 1717.3559915031863, 1869.224271927135, 1875.8499320054364, 930.8277968575835, 1003.9308136834248, 1076.8101248120713, 1106.7122548137381, 1129.6444266879778, 18624.906875465535, 21563.35309940673, 21645.783542164376, 21995.450113747283, 22074.558508829734, 1019.4851599942131, 1129.6611016694958, 1133.167122165208, 1141.452102990569, 1145.919785614999, 11478.426078696199, 11894.64316070502, 11930.88069119315, 11947.462364193632, 11979.341136237415, 595052.0, 601077.0, 608758.0, 621173.0, 621293.467663312, 105126.47436762767, 106026.46986765017, 106561.46719266353, 109705.45147274212, 110634.44682776695, 1012.1801340913884, 1109.046220250584, 1121.0863146535548, 1132.3828513460185, 1132.7451323452158, 19206.423807285802, 19414.320498782476, 19447.61104777925, 19493.61012779708, 19505.51236219049, 38336.80831595824, 49115.75442122766, 49872.50127498679, 50242.0, 50332.74833625808, 67686.91565521184, 68706.0, 69151.0, 70581.0, 70813.64593177, 7985.361171106414, 8119.391045671717, 8176.46852954556, 8204.753857384288, 8220.219079187467, 13364.665883352995, 13511.86488135106, 13573.52492662752, 13795.10331828428, 13966.860331396556, 9035.373632745906, 9746.658866939906, 11895.881041189477, 11972.521099155936, 12081.214721043105, 10030.398176109456, 11453.713657158638, 11493.827592586285, 11998.580049698568, 12052.975497082496, 11443.885561144281, 11771.823422648838, 11953.043756499634, 12050.578229761917, 12080.154389192672, 7963.442559021045, 7986.241307075818, 8066.1127275998415, 8204.220599043081, 8347.582620869054, 8482.287456958364, 11653.76692466129, 11789.469473873525, 11820.349880756641, 11968.640940771791], "unit": "score", "name": "jquery.html", "value": 9778.095323772099}, {"lowerIsBetter": false, "replicates": [1675.1540472061608, 1680.1095419427706, 2047.9590408191837, 2076.5360420903257, 2133.9786602133972, 6974.0, 8930.59812308446, 9048.954755226232, 9233.676821311265, 9263.675771348004, 8960.238379737713, 8972.820543589125, 9037.909620903805, 9065.546722663858, 9086.04596517366, 2545.2873195505194, 2566.4995325911455, 2569.6274040264243, 2570.9228723138335, 2583.1346498922885, 2502.2368177705794, 2556.0542599238306, 2560.2703229579574, 2560.590305551112, 2560.987195064022, 2128.19128731082, 2252.31304452142, 2407.241718858554, 2464.9400757674193, 2615.0847203478725, 2531.063506502587, 2533.7972962162985, 2561.8462892226435, 2563.4104156044214, 2567.7047139579, 1997.590493948737, 2504.4365017871014, 2556.9360765980814, 2561.705403878559, 2595.6755405574304, 9121.0, 9148.725538233864, 9170.174684278447, 9171.037041110721, 9178.586963586655, 4878.292647566083, 5589.217509548666, 5764.74058667361, 5765.365809760923, 5796.333421656522, 3605.801680907549, 3705.314516814398, 3723.7579557328686, 3745.756525825813, 3745.9625403745886, 936.391345625349, 1038.8857225705167, 1077.6928575355985, 1078.9406582637953, 1078.9892101078967, 12294.815577766341, 12365.629031129081, 12405.44175512104, 12421.813672794915, 12434.818692224315, 4970.627202959792, 5004.099262132779, 5032.949670503322, 5092.185250359925, 5092.770825312869, 10495.685129446128, 10538.367697938149, 10566.947165264124, 10575.36547807134, 10583.0, 5665.348484924204, 5667.631603945731, 5692.316921969307, 5730.713464326767, 5771.538276937835, 4241.406203131564, 4588.334691469719, 5099.847004589868, 5105.974470127626, 5121.820736274287, 4131.628153466202, 4168.7707176105, 4179.728317659343, 4186.434831297796, 4200.138971510833, 1343.0397265954693, 1363.584106847421, 1371.245814801875, 1375.8899288056932, 1380.8412032616177, 1176.5764324843221, 1179.8820117988305, 1189.4290740444635, 1200.477792160413, 1215.8297838302644, 8445.0, 8489.193526614961, 8506.064332923374, 8522.147785221552, 8597.355198360148, 1282.160185078775, 1286.8906142977764, 1294.7022184897526, 1311.1739604049387, 1344.2606566388447, 6492.350764923564, 6516.6415847128865, 6532.902006469907, 6593.7362505500205, 6608.7356505739235, 10626.426073353678, 11244.66266012021, 11268.436578171058, 11412.600558980395, 11417.143714221467, 10804.567817287221, 10956.780864382827, 11016.504257308441, 11103.333799972028, 11298.305254211935, 8678.86981695275, 8773.517456539952, 8810.427322224035, 8819.911800882037, 8897.466152030898, 8179.836403271782, 8233.50598964064, 8259.504429734236, 8300.377471689526, 8322.126176751353, 9696.5151742414, 9958.302918795614, 9963.202943764627, 9985.900140998498, 10015.048570385801, 10168.542415591464, 10405.47972601382, 10408.635697750542, 10530.315529490865, 10583.682489525327, 6531.836704082246, 7305.2329505403295, 7363.705451782083, 7366.410687145123, 7408.518446300973, 8684.088170742234, 8687.826243475221, 8698.086700896567, 8745.78135546591, 8793.988691300583, 7582.545047296959, 7774.183710710294, 7801.726939557088, 7803.609819508888, 7859.0, 7105.893411598727, 7124.0, 7131.893021604784, 7265.600391978492, 7276.599787011765, 8091.797705057421, 8119.106898241307, 8123.106458289465, 8141.145179756278, 8147.959260203661, 7249.963750181215, 7292.562446253241, 7335.926640733524, 7339.0, 7357.558546487228, 6742.988551717282, 6879.5184337095925, 7270.854582908418, 7318.121825380776, 7324.816879578053], "unit": "score", "name": "mootools.html", "value": 5124.977503982742}, {"lowerIsBetter": false, "replicates": [281.81963543332273, 287.5844404835013, 329.1606403670641, 335.0467918771095, 335.7381242630749, 6802.693878775454, 6875.071865298183, 6929.203141638713, 6963.79108626742, 7019.333163349486, 6829.0, 6855.657217139148, 6871.55334903231, 6875.862482750342, 6891.173059232887, 4731.124741922756, 4868.415790105192, 4958.305837182797, 5009.348784658007, 5061.797528098871, 3668.8899333020054, 4997.575206107467, 5048.6970781753025, 5056.671316364443, 5070.74646267687, 4961.454240033593, 4997.375328083989, 5003.649744517885, 5007.848194915154, 5042.067217564744, 5004.049230646202, 5005.224190250517, 5012.448630650625, 5029.5221953914315, 5030.723310217936, 4261.978690106561, 4263.829446822155, 4270.12462445198, 4279.465066866642, 4281.7002809803325, 5384.757685904144, 6390.680465976682, 6584.308647591982, 6680.86425307694, 6798.422134118606, 5882.6764527950945, 5948.464638182584, 5953.642781433128, 5973.432523910222, 6000.099985002241, 6674.666266686695, 7239.914012898054, 7304.452166087512, 7348.853022939565, 7362.7423040193335, 4787.16224660683, 4801.399825021872, 4814.927776083362, 4817.7591120444185, 4820.686655367425, 7784.961075194645, 7818.569978651172, 7829.29536341732, 7831.216878312181, 7856.096548896893, 4531.886702832389, 4741.596964258077, 4764.547368000034, 4767.594754445911, 4768.809247630125, 4799.088173247072, 4841.927371089437, 4858.659893807399, 4864.0, 4866.878328041827, 5054.21659642756, 5806.88386232273, 5853.356130825691, 5885.175595565388, 5886.646801191942, 7447.1063472382575, 7448.329650331496, 7461.141968673672, 7464.962675186589, 7473.476856620093, 1659.775930249425, 1672.2140593920838, 1672.5818545363659, 1673.3724853180058, 1684.8904821186584, 1021.213665477578, 1058.9629362972414, 1059.5484186664319, 1064.1486810551528, 1075.7687097273968, 6853.554518956252, 6875.1749790025515, 6913.89629155563, 6918.0314755934205, 6918.515703900679, 6229.221347331583, 7561.357284630868, 7619.123800762873, 7634.160242373335, 7670.232976702285, 6746.392824645805, 6822.3859852613505, 6887.966804979193, 6898.758543450955, 6946.16646002483, 4045.5752146024242, 4082.4284600156, 4100.425940368351, 4116.58834116586, 4123.154753275571, 8164.877526837102, 8173.918260817434, 8177.713780017671, 8193.426460147852, 8213.79465513355, 7813.413993950477, 7998.040235171817, 8039.155888631726, 8055.315298199719, 8063.4355595108955, 6587.089743974289, 8101.918980810352, 8119.431639785276, 8133.959330203311, 8180.222878826502, 6858.417034552119, 7196.10048743907, 7791.181925897699, 7794.2985131338455, 7806.765797026098, 7583.469157158946, 7593.962030189814, 7619.08570971487, 7621.1616722161625, 7622.733204337822, 7926.128125906261, 8126.0, 8139.308158806568, 8202.138775428493, 8223.753287401149, 4758.952410475851, 4811.230203167476, 4822.132016237111, 4826.8793280168275, 4829.1790395633525, 6620.768273110418, 7768.300852923264, 7786.649600767866, 7792.025996750406, 7808.102068262223, 7460.3658689012045, 7495.025646665898, 7497.512661676974, 7513.173550909505, 7526.811829704301, 7096.148462184365, 7351.044364232615, 7416.888746668912, 7467.2532746727065, 7518.699252029857, 7212.4590655699985, 7257.237990010973, 7285.635718214174, 7286.344229019413, 7297.562146271241, 6172.475339596184, 7437.107547094383, 7442.809150535888, 7464.440166987389, 7467.514611550232, 5905.730267992402, 7262.96368518154, 7278.490505664553, 7288.635568221674, 7339.449541284532], "unit": "score", "name": "prototype.html", "value": 5348.227566598636}, {"lowerIsBetter": false, "replicates": [706.777365129984, 707.8018154916625, 745.5899255409527, 765.2577000309701, 799.344537479267, 14820.592043755853, 15120.621984450381, 15164.469243576477, 15195.772063419045, 17747.201375938082, 16896.324147034135, 16967.0, 16983.320667173328, 16997.320107195726, 17057.0, 795.6578671171394, 963.1139351796329, 983.1986930651532, 989.1246247071358, 989.6635144051021, 985.6008316631776, 986.4328011393477, 987.8221920054388, 990.7126933189367, 990.9405435673847, 1048.3238311289215, 1048.6853943816864, 1049.7480604654866, 1049.837275222338, 1052.384355152233, 1027.850961610566, 1038.382162613244, 1039.3192458939368, 1040.0379648824808, 1040.5889673578895, 770.1335997003371, 771.5139462138873, 773.9690412383497, 776.996115019427, 779.9142094369615, 15755.369785208577, 15972.920135399365, 16205.91897040519, 16219.756703649455, 16240.269187886573, 12746.171498852545, 12857.45513801388, 12909.967202623768, 12924.741505169937, 12978.221306721627, 10026.037799360443, 10215.795684086352, 10306.175505959505, 10312.381257124596, 10383.688489345332, 3659.963400365989, 4154.31453810121, 4221.78891055446, 4353.41228934093, 4374.650027997753, 65849.67075164641, 77582.61208693977, 78748.21251787523, 78904.60547697225, 79238.60380698118, 9787.657431989846, 9883.950580247196, 9983.051610097029, 10101.0, 10260.794784104277, 22469.550608987727, 22469.66295505536, 22636.0, 23452.179173728837, 23936.760632393452, 7879.699849524764, 7937.722179723797, 7944.642491087915, 8039.554167456633, 8098.271155596025, 3947.7236593438756, 4140.296149654566, 4276.764777937181, 4282.935755963663, 4331.805068771912, 3781.0736369589076, 3821.121142137268, 3842.1355195080882, 3842.346801043829, 3849.3263678856088, 669.0532895952173, 675.2572170612287, 679.0730652659084, 688.707299397764, 689.1076056506836, 590.1825971030069, 599.310792588518, 600.8828278485653, 611.9077446757517, 623.2365352443221, 7311.159216690043, 7500.36246919018, 8094.392920530984, 8192.959035204905, 8394.160583941557, 460.7721665746155, 545.9890802183934, 547.7316115103571, 594.7154147042454, 595.2232336800516, 3630.4735813306925, 3744.1949980753725, 3782.6406491383273, 3784.829682664287, 3955.624215699504, 84904.15095849086, 86756.56621716851, 87512.0, 88538.55730721305, 89184.6622300666, 76909.61545192238, 77498.6125069371, 77711.22288777152, 80056.59971700104, 80418.0, 63161.684191578745, 63982.6800866002, 65851.01223481652, 66464.33535664678, 66754.0, 7325.120985481776, 7512.436567257587, 7646.388288936983, 7780.533168009937, 7988.600569971594, 41489.96275093147, 45930.770346149395, 49976.75011624918, 50474.99050019053, 52184.0, 63076.05385919307, 69158.65420672865, 70403.0, 70543.0, 71500.64249678719, 10324.48377581133, 10522.053015228359, 10569.207309451667, 10591.152707783205, 10807.837882431613, 10613.522391492246, 10622.468876555986, 10697.625583104555, 10722.678319650424, 11015.008649221609, 10241.283110182514, 10412.167026637699, 10441.0, 10488.213383996079, 10544.84182737275, 10093.596256149673, 10125.0, 10170.745731356776, 10202.540885660015, 10380.532876020749, 9787.21702263803, 10057.943915888727, 10143.391396516232, 10373.118284945562, 10478.685639430829, 8423.284020858297, 8423.32613390915, 8568.828623427622, 8599.312055035707, 8780.121987801169, 7530.277784685826, 8738.126187381211, 8844.0, 8863.556822158995, 9198.172164505228], "unit": "score", "name": "yui.html", "value": 6958.9506715343805}], "name": "dromaeo_css", "value": 7728.35540357449}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 108.0, 115.0, 114.0, 115.0, 135.0, 136.0, 118.0, 114.0, 116.0], "unit": "score", "name": "ai-astar", "value": 118.7}, {"lowerIsBetter": true, "replicates": [162.0, 131.0, 144.0, 154.0, 143.0, 168.0, 156.0, 119.0, 159.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [201.0, 200.0, 201.0, 203.0, 229.0, 195.0, 194.0, 199.0, 202.0, 199.0], "unit": "score", "name": "audio-dft", "value": 202.3}, {"lowerIsBetter": true, "replicates": [65.0, 74.0, 89.0, 109.0, 82.0, 82.0, 84.0, 84.0, 135.0, 57.0], "unit": "score", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 120.0, 66.0, 95.0, 121.0, 152.0, 89.0, 78.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 101.7}, {"lowerIsBetter": true, "replicates": [131.0, 91.0, 91.0, 124.0, 90.0, 85.0, 91.0, 87.0, 105.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.6}, {"lowerIsBetter": true, "replicates": [96.0, 106.0, 95.0, 96.0, 96.0, 95.0, 95.0, 97.0, 94.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 96.6}, {"lowerIsBetter": true, "replicates": [97.0, 92.0, 140.0, 147.0, 129.0, 99.0, 93.0, 91.0, 125.0, 115.0], "unit": "score", "name": "imaging-desaturate", "value": 112.8}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 59.0, 60.0, 59.0, 58.0, 59.0, 67.0, 58.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 72.0, 73.0, 79.0, 73.0, 71.0, 67.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [76.0, 86.0, 75.0, 100.0, 106.0, 100.0, 84.0, 81.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [140.0, 130.0, 127.0, 129.0, 122.0, 148.0, 133.0, 134.0, 146.0, 142.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.1}, {"lowerIsBetter": true, "replicates": [137.0, 139.0, 144.0, 152.0, 144.0, 139.0, 132.0, 137.0, 153.0, 166.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [69.0, 75.0, 93.0, 92.0, 84.0, 57.0, 90.0, 63.0, 59.0, 76.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.8}], "name": "kraken", "value": 1536.3999999999999}]} 05:26:31 INFO - Return code: 0 05:26:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:26:31 ERROR - # TBPL SUCCESS # 05:26:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:31 INFO - 2016-04-07 05:26:31.687 screenresolution[1983:23026] starting screenresolution argv=screenresolution get 05:26:31 INFO - 2016-04-07 05:26:31.689 screenresolution[1983:23026] Display 0: 1600x1200x32@60 05:26:31 INFO - 2016-04-07 05:26:31.695 screenresolution[1984:23029] starting screenresolution argv=screenresolution list 05:26:31 INFO - Available Modes on Display 0 05:26:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:31 INFO - Intel Iris: 05:26:31 INFO - Chipset Model: Intel Iris 05:26:31 INFO - Type: GPU 05:26:31 INFO - Bus: Built-In 05:26:31 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:31 INFO - Vendor: Intel (0x8086) 05:26:31 INFO - Device ID: 0x0a2e 05:26:31 INFO - Revision ID: 0x0009 05:26:31 INFO - Displays: 05:26:31 INFO - Display: 05:26:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:31 INFO - Display Serial Number: 1600x1200 60 05:26:31 INFO - Main Display: Yes 05:26:31 INFO - Mirror: Off 05:26:31 INFO - Online: Yes 05:26:31 INFO - Rotation: Supported 05:26:31 INFO - Return code: 0 05:26:31 INFO - Running post-action listener: _resource_record_post_action 05:26:31 INFO - Running post-run listener: _resource_record_post_run 05:26:32 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 540672; Write bytes: 667059200; Read time: 9; Write time: 2115 05:26:32 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 352156160; Write bytes: 353732608; Read time: 27683; Write time: 749 05:26:32 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 446464; Write bytes: 302988288; Read time: 5; Write time: 1328 05:26:32 INFO - Running post-run listener: _upload_blobber_files 05:26:32 INFO - Blob upload gear active. 05:26:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:26:32 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:26:32 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:26:33 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:34 INFO - (blobuploader) - INFO - Done attempting. 05:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:26:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:35 INFO - (blobuploader) - INFO - Done attempting. 05:26:35 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:35 INFO - Return code: 0 05:26:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b1393b2828ae9bc0ddb6fa8bb0eba0f4874acd8834532b15333a3bd378cf7bae34d7f28f98fc5bc97464da56fa2c2267ec7932da32b88cae1f8c4471b6773b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3537b813f5da2d276219c3ea26b9d71272aa254b760901a6dd9657eccd6dace56242bb41720b04b451de8edbca20ba7922a7d22c7caa21ed1835ad4cb869c60e"} 05:26:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:35 INFO - Contents: 05:26:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b1393b2828ae9bc0ddb6fa8bb0eba0f4874acd8834532b15333a3bd378cf7bae34d7f28f98fc5bc97464da56fa2c2267ec7932da32b88cae1f8c4471b6773b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3537b813f5da2d276219c3ea26b9d71272aa254b760901a6dd9657eccd6dace56242bb41720b04b451de8edbca20ba7922a7d22c7caa21ed1835ad4cb869c60e"} 05:26:35 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:35 INFO - Copying logs to upload dir... 05:26:35 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.742372 ========= master_lag: 1.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-07 05:26:36.804361) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-04-07 05:26:36.807136) ========= 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.4ffahpi3M4/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.9yjNNfbU44/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b1393b2828ae9bc0ddb6fa8bb0eba0f4874acd8834532b15333a3bd378cf7bae34d7f28f98fc5bc97464da56fa2c2267ec7932da32b88cae1f8c4471b6773b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3537b813f5da2d276219c3ea26b9d71272aa254b760901a6dd9657eccd6dace56242bb41720b04b451de8edbca20ba7922a7d22c7caa21ed1835ad4cb869c60e"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011033 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b1393b2828ae9bc0ddb6fa8bb0eba0f4874acd8834532b15333a3bd378cf7bae34d7f28f98fc5bc97464da56fa2c2267ec7932da32b88cae1f8c4471b6773b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3537b813f5da2d276219c3ea26b9d71272aa254b760901a6dd9657eccd6dace56242bb41720b04b451de8edbca20ba7922a7d22c7caa21ed1835ad4cb869c60e"}' ========= master_lag: 14.66 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 14 secs) (at 2016-04-07 05:26:51.479232) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 05:26:51.487747) ========= 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.4ffahpi3M4/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.9yjNNfbU44/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005253 ========= master_lag: 1.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 05:26:52.548838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:26:52.549164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:26:52.581595) ========= ========= Total master_lag: 17.23 =========