builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0186 starttime: 1459340489.34 results: success (0) buildid: 20160330030326 builduid: 0c5e38b63ef04aa8a520b9b40bbea151 revision: d5d53a3b4e50b94cdf85d20690526e5a00d5b63e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.343122) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.343568) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.343866) ========= 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.T6G6lLsCf1/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.PrL5n2emwq/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005558 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.368636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.368981) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.386048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.386314) ========= 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.T6G6lLsCf1/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.PrL5n2emwq/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005643 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.434688) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.435001) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.435371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.435643) ========= 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.T6G6lLsCf1/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.PrL5n2emwq/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-30 05:21:29-- 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% 28.2M=0s 2016-03-30 05:21:29 (28.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179769 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.633786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.634439) ========= 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.T6G6lLsCf1/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.PrL5n2emwq/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.027402 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:29.687143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-30 05:21:29.687829) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d5d53a3b4e50b94cdf85d20690526e5a00d5b63e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d5d53a3b4e50b94cdf85d20690526e5a00d5b63e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T6G6lLsCf1/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.PrL5n2emwq/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-30 05:21:29,773 truncating revision to first 12 chars 2016-03-30 05:21:29,773 Setting DEBUG logging. 2016-03-30 05:21:29,774 attempt 1/10 2016-03-30 05:21:29,774 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d5d53a3b4e50?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-30 05:21:31,279 unpacking tar archive at: mozilla-central-d5d53a3b4e50/testing/mozharness/ program finished with exit code 0 elapsedTime=1.757831 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-30 05:21:31.464418) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:31.464826) ========= echo d5d53a3b4e50b94cdf85d20690526e5a00d5b63e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd5d53a3b4e50b94cdf85d20690526e5a00d5b63e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T6G6lLsCf1/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.PrL5n2emwq/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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 d5d53a3b4e50b94cdf85d20690526e5a00d5b63e program finished with exit code 0 elapsedTime=0.005320 script_repo_revision: 'd5d53a3b4e50b94cdf85d20690526e5a00d5b63e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:31.515232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:31.515590) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:31.530485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-30 05:21:31.530828) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T6G6lLsCf1/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.PrL5n2emwq/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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:21:31 INFO - MultiFileLogger online at 20160330 05:21:31 in /builds/slave/test 05:21:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:21:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:31 INFO - {'append_to_log': False, 05:21:31 INFO - 'base_work_dir': '/builds/slave/test', 05:21:31 INFO - 'blob_upload_branch': 'Firefox', 05:21:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:31 INFO - 'branch': 'Firefox', 05:21:31 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:31 INFO - 'config_files': ('talos/mac_config.py',), 05:21:31 INFO - 'default_actions': ('clobber', 05:21:31 INFO - 'read-buildbot-config', 05:21:31 INFO - 'download-and-extract', 05:21:31 INFO - 'populate-webroot', 05:21:31 INFO - 'create-virtualenv', 05:21:31 INFO - 'install', 05:21:31 INFO - 'run-tests'), 05:21:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:31 INFO - 'download_minidump_stackwalk': True, 05:21:31 INFO - 'download_symbols': 'ondemand', 05:21:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:31 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:31 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:31 INFO - 'installer_path': 'installer.exe', 05:21:31 INFO - 'log_level': 'info', 05:21:31 INFO - 'log_name': 'talos', 05:21:31 INFO - 'log_to_console': True, 05:21:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:21:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:21:31 INFO - 'opt_config_files': (), 05:21:31 INFO - 'pip_index': False, 05:21:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:21:31 INFO - 'cmd': ('bash', 05:21:31 INFO - '-c', 05:21:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:21:31 INFO - 'enabled': True, 05:21:31 INFO - 'halt_on_failure': False, 05:21:31 INFO - 'name': 'check_screen_resolution'},), 05:21:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:21:31 INFO - 'cmd': ('bash', 05:21:31 INFO - '-c', 05:21:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:21:31 INFO - 'enabled': True, 05:21:31 INFO - 'halt_on_failure': False, 05:21:31 INFO - 'name': 'check_screen_resolution'},), 05:21:31 INFO - 'run_cmd_checks_enabled': True, 05:21:31 INFO - 'sps_profile': False, 05:21:31 INFO - 'sps_profile_interval': 0, 05:21:31 INFO - 'suite': 'dromaeojs-e10s', 05:21:31 INFO - 'system_bits': '32', 05:21:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:31 INFO - 'title': 't-yosemite-r7-0186', 05:21:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:31 INFO - 'use_talos_json': True, 05:21:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:31 INFO - 'work_dir': 'build'} 05:21:31 INFO - ##### 05:21:31 INFO - ##### Running clobber step. 05:21:31 INFO - ##### 05:21:31 INFO - Running pre-action listener: _resource_record_pre_action 05:21:31 INFO - Running main action method: clobber 05:21:31 INFO - rmtree: /builds/slave/test/build 05:21:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:33 INFO - Running post-action listener: _resource_record_post_action 05:21:33 INFO - ##### 05:21:33 INFO - ##### Running read-buildbot-config step. 05:21:33 INFO - ##### 05:21:33 INFO - Running pre-action listener: _resource_record_pre_action 05:21:33 INFO - Running main action method: read_buildbot_config 05:21:33 INFO - Using buildbot properties: 05:21:33 INFO - { 05:21:33 INFO - "project": "", 05:21:33 INFO - "product": "firefox", 05:21:33 INFO - "script_repo_revision": "production", 05:21:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:21:33 INFO - "repository": "", 05:21:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:21:33 INFO - "buildid": "20160330030326", 05:21:33 INFO - "stage_platform": "macosx64", 05:21:33 INFO - "basedir": "/builds/slave/test", 05:21:33 INFO - "nightly_build": "True", 05:21:33 INFO - "buildnumber": 159, 05:21:33 INFO - "slavename": "t-yosemite-r7-0186", 05:21:33 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:21:33 INFO - "platform": "yosemite_r7", 05:21:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:21:33 INFO - "branch": "mozilla-central", 05:21:33 INFO - "repo_path": "mozilla-central", 05:21:33 INFO - "revision": "d5d53a3b4e50b94cdf85d20690526e5a00d5b63e", 05:21:33 INFO - "pgo_build": "False", 05:21:33 INFO - "builduid": "0c5e38b63ef04aa8a520b9b40bbea151", 05:21:33 INFO - "slavebuilddir": "test" 05:21:33 INFO - } 05:21:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:21:33 INFO - Running post-action listener: _resource_record_post_action 05:21:33 INFO - ##### 05:21:33 INFO - ##### Running download-and-extract step. 05:21:33 INFO - ##### 05:21:33 INFO - Running pre-action listener: _resource_record_pre_action 05:21:33 INFO - Running main action method: download_and_extract 05:21:33 INFO - mkdir: /builds/slave/test/build/tests 05:21:33 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:21:33 INFO - https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:21:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:21:34 INFO - Downloaded 1199 bytes. 05:21:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:34 INFO - Using the following test package requirements: 05:21:34 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:21:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:34 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:21:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:34 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:21:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:34 INFO - u'jsshell-mac.zip'], 05:21:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:34 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:21:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:21:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:34 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:21:34 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:34 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:21:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:34 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:21:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:34 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:21:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:21:34 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:21:34 INFO - https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:21:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:21:35 INFO - Downloaded 17944949 bytes. 05:21:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:21:39 INFO - Return code: 0 05:21:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:39 INFO - https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:21:40 INFO - Downloaded 17944949 bytes. 05:21:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:21:43 INFO - Return code: 0 05:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:43 INFO - https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:21:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:21:44 INFO - Downloaded 10847531 bytes. 05:21:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:21:45 INFO - Return code: 0 05:21: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:21:45 INFO - https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:21:48 INFO - Downloaded 111535949 bytes. 05:21:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:48 INFO - mkdir: /builds/slave/test/properties 05:21:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:48 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:48 INFO - Contents: 05:21:48 INFO - build_url:https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:49 INFO - Running post-action listener: _resource_record_post_action 05:21:49 INFO - Running post-action listener: set_extra_try_arguments 05:21:49 INFO - ##### 05:21:49 INFO - ##### Running populate-webroot step. 05:21:49 INFO - ##### 05:21:49 INFO - Running pre-action listener: _resource_record_pre_action 05:21:49 INFO - Running main action method: populate_webroot 05:21:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:49 INFO - '--tppagecycles', 05:21:49 INFO - '7'], 05:21:49 INFO - 'tests': ['tsvgm']}}, 05:21:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:21:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:21:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:21:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:21:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:49 INFO - 'talos_options': ['--e10s'], 05:21:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:49 INFO - 'tests': ['damp', 'tps']}, 05:21:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:49 INFO - 'talos_options': ['--e10s'], 05:21:49 INFO - 'tests': ['damp', 'tps']}, 05:21:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:21:49 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 05:21:49 INFO - 'tests': ['dromaeo_dom']}, 05:21:49 INFO - 'other': {'tests': ['a11yr', 05:21:49 INFO - 'ts_paint', 05:21:49 INFO - 'tpaint', 05:21:49 INFO - 'sessionrestore', 05:21:49 INFO - 'sessionrestore_no_auto_restore', 05:21:49 INFO - 'tabpaint']}, 05:21:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:21:49 INFO - 'tests': ['a11yr', 05:21:49 INFO - 'ts_paint', 05:21:49 INFO - 'tpaint', 05:21:49 INFO - 'sessionrestore', 05:21:49 INFO - 'sessionrestore_no_auto_restore', 05:21:49 INFO - 'tabpaint']}, 05:21:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:21:49 INFO - 'tests': ['a11yr', 05:21:49 INFO - 'ts_paint', 05:21:49 INFO - 'tpaint', 05:21:49 INFO - 'sessionrestore', 05:21:49 INFO - 'sessionrestore_no_auto_restore', 05:21:49 INFO - 'tabpaint']}, 05:21:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:21:49 INFO - 'tests': ['a11yr', 05:21:49 INFO - 'ts_paint', 05:21:49 INFO - 'tpaint', 05:21:49 INFO - 'sessionrestore', 05:21:49 INFO - 'sessionrestore_no_auto_restore', 05:21:49 INFO - 'tabpaint']}, 05:21:49 INFO - 'other_l64': {'tests': ['a11yr', 05:21:49 INFO - 'ts_paint', 05:21:49 INFO - 'tpaint', 05:21:49 INFO - 'sessionrestore', 05:21:49 INFO - 'sessionrestore_no_auto_restore', 05:21:49 INFO - 'tabpaint']}, 05:21:49 INFO - 'other_nol64': {'tests': ['a11yr', 05:21:49 INFO - 'ts_paint', 05:21:49 INFO - 'tpaint', 05:21:49 INFO - 'sessionrestore', 05:21:49 INFO - 'sessionrestore_no_auto_restore', 05:21:49 INFO - 'tabpaint']}, 05:21:49 INFO - 'svgr': {'tests': ['tsvgx', 05:21:49 INFO - 'tsvgr_opacity', 05:21:49 INFO - 'tart', 05:21:49 INFO - 'tscrollx', 05:21:49 INFO - 'cart']}, 05:21:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:21:49 INFO - 'tests': ['tsvgx', 05:21:49 INFO - 'tsvgr_opacity', 05:21:49 INFO - 'tart', 05:21:49 INFO - 'tscrollx', 05:21:49 INFO - 'cart']}, 05:21:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:49 INFO - 'tests': ['tp5o']}, 05:21:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:49 INFO - 'talos_options': ['--e10s'], 05:21:49 INFO - 'tests': ['tp5o']}, 05:21:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:49 INFO - 'talos_options': ['--xperf_path', 05:21:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:49 INFO - 'tests': ['tp5n']}, 05:21:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:49 INFO - 'talos_options': ['--e10s', 05:21:49 INFO - '--xperf_path', 05:21:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:49 INFO - 'tests': ['tp5n']}}, 05:21:49 INFO - 'talos.zip': {'path': '', 05:21:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:49 INFO - Running post-action listener: _resource_record_post_action 05:21:49 INFO - ##### 05:21:49 INFO - ##### Running create-virtualenv step. 05:21:49 INFO - ##### 05:21:49 INFO - Running pre-action listener: _resource_record_pre_action 05:21:49 INFO - Running main action method: create_virtualenv 05:21:49 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:49 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:21:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:49 INFO - Using real prefix '/tools/python27' 05:21:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:52 INFO - Installing pip.................done. 05:21:52 INFO - Return code: 0 05:21:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21: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:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:52 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 0x102ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9181ccbe00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102972e00>, '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 0x1027dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10296db20>, '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.T6G6lLsCf1/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.PrL5n2emwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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:21:52 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:21:52 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:21:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T6G6lLsCf1/Render', 05:21:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:52 INFO - 'HOME': '/Users/cltbld', 05:21:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:52 INFO - 'LOGNAME': 'cltbld', 05:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:52 INFO - 'MOZ_NO_REMOTE': '1', 05:21:52 INFO - 'NO_EM_RESTART': '1', 05:21:52 INFO - 'PAGER': '/bin/cat', 05:21:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:52 INFO - 'PWD': '/builds/slave/test', 05:21:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:52 INFO - 'SHELL': '/bin/bash', 05:21:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PrL5n2emwq/Listeners', 05:21:52 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 05:21:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:52 INFO - 'USER': 'cltbld', 05:21:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:52 INFO - 'XPC_FLAGS': '0x0', 05:21:52 INFO - 'XPC_SERVICE_NAME': '0', 05:21:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:53 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:21:53 INFO - Cleaning up... 05:21:53 INFO - Return code: 0 05:21:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:21: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:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:53 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 0x102ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9181ccbe00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102972e00>, '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 0x1027dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10296db20>, '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.T6G6lLsCf1/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.PrL5n2emwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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:21:53 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:21:53 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:21:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T6G6lLsCf1/Render', 05:21:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:53 INFO - 'HOME': '/Users/cltbld', 05:21:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:53 INFO - 'LOGNAME': 'cltbld', 05:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:53 INFO - 'MOZ_NO_REMOTE': '1', 05:21:53 INFO - 'NO_EM_RESTART': '1', 05:21:53 INFO - 'PAGER': '/bin/cat', 05:21:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:53 INFO - 'PWD': '/builds/slave/test', 05:21:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:53 INFO - 'SHELL': '/bin/bash', 05:21:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PrL5n2emwq/Listeners', 05:21:53 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 05:21:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:53 INFO - 'USER': 'cltbld', 05:21:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:53 INFO - 'XPC_FLAGS': '0x0', 05:21:53 INFO - 'XPC_SERVICE_NAME': '0', 05:21:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:53 INFO - Downloading/unpacking psutil>=0.7.1 05:21:53 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:21:53 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:21:53 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:21:53 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:21:53 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:21:53 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:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:55 INFO - Installing collected packages: psutil 05:21:55 INFO - Running setup.py install for psutil 05:21:56 INFO - building 'psutil._psutil_osx' extension 05:21:56 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:21:56 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:21:56 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:21:56 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:21:56 INFO - building 'psutil._psutil_posix' extension 05:21:56 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:21:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:21:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:21:56 INFO - ^ 05:21:56 INFO - 1 warning generated. 05:21:56 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:21:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:57 INFO - Successfully installed psutil 05:21:57 INFO - Cleaning up... 05:21:57 INFO - Return code: 0 05:21:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:21:57 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:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:57 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:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:57 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 0x102ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9181ccbe00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102972e00>, '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 0x1027dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10296db20>, '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.T6G6lLsCf1/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.PrL5n2emwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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:21:57 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:21:57 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:21:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T6G6lLsCf1/Render', 05:21:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:57 INFO - 'HOME': '/Users/cltbld', 05:21:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:57 INFO - 'LOGNAME': 'cltbld', 05:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:57 INFO - 'MOZ_NO_REMOTE': '1', 05:21:57 INFO - 'NO_EM_RESTART': '1', 05:21:57 INFO - 'PAGER': '/bin/cat', 05:21:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:57 INFO - 'PWD': '/builds/slave/test', 05:21:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:57 INFO - 'SHELL': '/bin/bash', 05:21:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PrL5n2emwq/Listeners', 05:21:57 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 05:21:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:57 INFO - 'USER': 'cltbld', 05:21:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:57 INFO - 'XPC_FLAGS': '0x0', 05:21:57 INFO - 'XPC_SERVICE_NAME': '0', 05:21:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:22:00 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:22:00 INFO - Installing collected packages: mozsystemmonitor 05:22:00 INFO - Running setup.py install for mozsystemmonitor 05:22:00 INFO - Successfully installed mozsystemmonitor 05:22:00 INFO - Cleaning up... 05:22:00 INFO - Return code: 0 05:22:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:22: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:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:00 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 0x102ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9181ccbe00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102972e00>, '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 0x1027dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10296db20>, '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.T6G6lLsCf1/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.PrL5n2emwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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:22:00 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:22:00 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:22:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T6G6lLsCf1/Render', 05:22:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:00 INFO - 'HOME': '/Users/cltbld', 05:22:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:00 INFO - 'LOGNAME': 'cltbld', 05:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:00 INFO - 'MOZ_NO_REMOTE': '1', 05:22:00 INFO - 'NO_EM_RESTART': '1', 05:22:00 INFO - 'PAGER': '/bin/cat', 05:22:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:00 INFO - 'PWD': '/builds/slave/test', 05:22:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:00 INFO - 'SHELL': '/bin/bash', 05:22:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PrL5n2emwq/Listeners', 05:22:00 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 05:22:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:00 INFO - 'USER': 'cltbld', 05:22:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:00 INFO - 'XPC_FLAGS': '0x0', 05:22:00 INFO - 'XPC_SERVICE_NAME': '0', 05:22:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:03 INFO - Downloading blobuploader-1.2.4.tar.gz 05:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:22:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:22:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:04 INFO - Downloading docopt-0.6.1.tar.gz 05:22:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:22:04 INFO - Installing collected packages: blobuploader, requests, docopt 05:22:04 INFO - Running setup.py install for blobuploader 05:22:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:22:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:22:04 INFO - Running setup.py install for requests 05:22:04 INFO - Running setup.py install for docopt 05:22:05 INFO - Successfully installed blobuploader requests docopt 05:22:05 INFO - Cleaning up... 05:22:05 INFO - Return code: 0 05:22:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22: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:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:05 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 0x102ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9181ccbe00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102972e00>, '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 0x1027dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10296db20>, '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.T6G6lLsCf1/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.PrL5n2emwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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:22:05 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:22:05 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:22:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T6G6lLsCf1/Render', 05:22:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:05 INFO - 'HOME': '/Users/cltbld', 05:22:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:05 INFO - 'LOGNAME': 'cltbld', 05:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:05 INFO - 'MOZ_NO_REMOTE': '1', 05:22:05 INFO - 'NO_EM_RESTART': '1', 05:22:05 INFO - 'PAGER': '/bin/cat', 05:22:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:05 INFO - 'PWD': '/builds/slave/test', 05:22:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:05 INFO - 'SHELL': '/bin/bash', 05:22:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PrL5n2emwq/Listeners', 05:22:05 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 05:22:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:05 INFO - 'USER': 'cltbld', 05:22:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:05 INFO - 'XPC_FLAGS': '0x0', 05:22:05 INFO - 'XPC_SERVICE_NAME': '0', 05:22:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:05 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-qOGgZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:05 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-eq0nOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:05 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-n6iwBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:05 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-OW2MT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:05 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-MleYSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:06 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-fW3ffO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:06 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-0FyIPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:06 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-f0a_AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:06 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-dwfdT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:06 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-NVXxIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:06 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-8SbA34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:06 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-LSLwJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:06 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-PbJ2W7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:06 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-eoJuEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:06 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-UKzPgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:07 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-vBitTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:07 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-M_jhQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:22:07 INFO - Running setup.py install for manifestparser 05:22:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:22:07 INFO - Running setup.py install for mozcrash 05:22:07 INFO - Running setup.py install for mozdebug 05:22:07 INFO - Running setup.py install for mozdevice 05:22:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:22:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:22:07 INFO - Running setup.py install for mozfile 05:22:08 INFO - Running setup.py install for mozhttpd 05:22:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:22:08 INFO - Running setup.py install for mozinfo 05:22:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:22:08 INFO - Running setup.py install for mozInstall 05:22:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:22:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:22:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:22:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:22:08 INFO - Running setup.py install for mozleak 05:22:08 INFO - Running setup.py install for mozlog 05:22:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:22:08 INFO - Running setup.py install for moznetwork 05:22:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:22:08 INFO - Running setup.py install for mozprocess 05:22:09 INFO - Running setup.py install for mozprofile 05:22:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:22:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:22:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:22:09 INFO - Running setup.py install for mozrunner 05:22:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:22:09 INFO - Running setup.py install for mozscreenshot 05:22:09 INFO - Running setup.py install for moztest 05:22:09 INFO - Running setup.py install for mozversion 05:22:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:22:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:22:09 INFO - Cleaning up... 05:22:09 INFO - Return code: 0 05:22:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:10 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 0x102ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9181ccbe00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102972e00>, '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 0x1027dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10296db20>, '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.T6G6lLsCf1/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.PrL5n2emwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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:22:10 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:22:10 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:22:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T6G6lLsCf1/Render', 05:22:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:10 INFO - 'HOME': '/Users/cltbld', 05:22:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:10 INFO - 'LOGNAME': 'cltbld', 05:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:10 INFO - 'MOZ_NO_REMOTE': '1', 05:22:10 INFO - 'NO_EM_RESTART': '1', 05:22:10 INFO - 'PAGER': '/bin/cat', 05:22:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:10 INFO - 'PWD': '/builds/slave/test', 05:22:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:10 INFO - 'SHELL': '/bin/bash', 05:22:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PrL5n2emwq/Listeners', 05:22:10 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 05:22:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:10 INFO - 'USER': 'cltbld', 05:22:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:10 INFO - 'XPC_FLAGS': '0x0', 05:22:10 INFO - 'XPC_SERVICE_NAME': '0', 05:22:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:22:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-HHoQ5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:22:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-kNxiD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:22:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-PgNtz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:22:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-6v8kX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:22:10 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:22:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:22:10 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-RMVh7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:22:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-enJbtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:22:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-pFonIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:22:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-Ocb5HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:22:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-qETHbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:22:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-OZ3ymi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:22:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-k1PMXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:22:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-bUh1Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:22:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-fndU5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:22:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-7F20SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:22:11 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:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:11 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-KLrvtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:22:12 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:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:22:12 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-ncOFIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:22:12 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:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:22:12 INFO - Running setup.py (path:/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/pip-9PjLA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:22:12 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:22:12 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:22:12 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:22:12 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:22:12 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:22:12 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:22:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:22:12 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:22:12 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:22:12 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:22:12 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:22:12 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:22:12 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:22:15 INFO - Downloading blessings-1.6.tar.gz 05:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:22:15 INFO - Installing collected packages: blessings 05:22:15 INFO - Running setup.py install for blessings 05:22:15 INFO - Successfully installed blessings 05:22:15 INFO - Cleaning up... 05:22:15 INFO - Return code: 0 05:22:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:22:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:15 INFO - Reading from file tmpfile_stdout 05:22:15 INFO - Current package versions: 05:22:15 INFO - blessings == 1.6 05:22:15 INFO - blobuploader == 1.2.4 05:22:15 INFO - docopt == 0.6.1 05:22:15 INFO - manifestparser == 1.1 05:22:15 INFO - mozInstall == 1.12 05:22:15 INFO - mozcrash == 0.17 05:22:15 INFO - mozdebug == 0.1 05:22:15 INFO - mozdevice == 0.48 05:22:15 INFO - mozfile == 1.2 05:22:15 INFO - mozhttpd == 0.7 05:22:15 INFO - mozinfo == 0.9 05:22:15 INFO - mozleak == 0.1 05:22:15 INFO - mozlog == 3.1 05:22:15 INFO - moznetwork == 0.27 05:22:15 INFO - mozprocess == 0.22 05:22:15 INFO - mozprofile == 0.28 05:22:15 INFO - mozrunner == 6.11 05:22:15 INFO - mozscreenshot == 0.1 05:22:15 INFO - mozsystemmonitor == 0.0 05:22:15 INFO - moztest == 0.7 05:22:15 INFO - mozversion == 1.4 05:22:15 INFO - psutil == 3.1.1 05:22:15 INFO - requests == 1.2.3 05:22:15 INFO - wsgiref == 0.1.2 05:22:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:15 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 0x102ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9181ccbe00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102972e00>, '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 0x1027dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10296db20>, '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.T6G6lLsCf1/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.PrL5n2emwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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:22:15 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:22:15 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:22:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T6G6lLsCf1/Render', 05:22:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:15 INFO - 'HOME': '/Users/cltbld', 05:22:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:15 INFO - 'LOGNAME': 'cltbld', 05:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:15 INFO - 'MOZ_NO_REMOTE': '1', 05:22:15 INFO - 'NO_EM_RESTART': '1', 05:22:15 INFO - 'PAGER': '/bin/cat', 05:22:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:15 INFO - 'PWD': '/builds/slave/test', 05:22:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:15 INFO - 'SHELL': '/bin/bash', 05:22:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PrL5n2emwq/Listeners', 05:22:15 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 05:22:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:15 INFO - 'USER': 'cltbld', 05:22:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:15 INFO - 'XPC_FLAGS': '0x0', 05:22:15 INFO - 'XPC_SERVICE_NAME': '0', 05:22:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:15 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:22:15 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:22:15 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:22:15 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:22:15 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:22:15 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:22:15 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:22:15 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:22:15 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:22:15 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:22:15 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:22:15 INFO - Cleaning up... 05:22:15 INFO - Return code: 0 05:22:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:15 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 0x102ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9181ccbe00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102972e00>, '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 0x1027dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10296db20>, '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.T6G6lLsCf1/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.PrL5n2emwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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:22:15 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:22:16 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:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T6G6lLsCf1/Render', 05:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:16 INFO - 'HOME': '/Users/cltbld', 05:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:16 INFO - 'LOGNAME': 'cltbld', 05:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:16 INFO - 'MOZ_NO_REMOTE': '1', 05:22:16 INFO - 'NO_EM_RESTART': '1', 05:22:16 INFO - 'PAGER': '/bin/cat', 05:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:16 INFO - 'PWD': '/builds/slave/test', 05:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:16 INFO - 'SHELL': '/bin/bash', 05:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PrL5n2emwq/Listeners', 05:22:16 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 05:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:16 INFO - 'USER': 'cltbld', 05:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:16 INFO - 'XPC_FLAGS': '0x0', 05:22:16 INFO - 'XPC_SERVICE_NAME': '0', 05:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:16 INFO - Downloading/unpacking jsonschema 05:22: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:22: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:22: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:22: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:22: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:22: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:22:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:22:18 INFO - Downloading/unpacking functools32 (from jsonschema) 05:22:18 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:22:18 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:22:18 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:22:18 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:22:18 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:22:18 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:22:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:22:19 INFO - warning: no files found matching '*.txt' 05:22:19 INFO - no previously-included directories found matching 'build' 05:22:19 INFO - no previously-included directories found matching 'dist' 05:22:19 INFO - no previously-included directories found matching '.git*' 05:22:19 INFO - Installing collected packages: jsonschema, functools32 05:22:19 INFO - Running setup.py install for functools32 05:22:19 INFO - warning: no files found matching '*.txt' 05:22:19 INFO - no previously-included directories found matching 'build' 05:22:19 INFO - no previously-included directories found matching 'dist' 05:22:19 INFO - no previously-included directories found matching '.git*' 05:22:19 INFO - Successfully installed jsonschema functools32 05:22:19 INFO - Cleaning up... 05:22:19 INFO - Return code: 0 05:22:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:22: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:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:19 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 0x102ad3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ae3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9181ccbe00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102972e00>, '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 0x1027dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10296db20>, '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.T6G6lLsCf1/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.PrL5n2emwq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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:22:19 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:22:19 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:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T6G6lLsCf1/Render', 05:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:19 INFO - 'HOME': '/Users/cltbld', 05:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:19 INFO - 'LOGNAME': 'cltbld', 05:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:19 INFO - 'MOZ_NO_REMOTE': '1', 05:22:19 INFO - 'NO_EM_RESTART': '1', 05:22:19 INFO - 'PAGER': '/bin/cat', 05:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:19 INFO - 'PWD': '/builds/slave/test', 05:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:19 INFO - 'SHELL': '/bin/bash', 05:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PrL5n2emwq/Listeners', 05:22:19 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 05:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:19 INFO - 'USER': 'cltbld', 05:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:19 INFO - 'XPC_FLAGS': '0x0', 05:22:19 INFO - 'XPC_SERVICE_NAME': '0', 05:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:19 INFO - Downloading/unpacking flake8 05:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:19 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:22:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:22:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:22: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:22: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:22: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:22: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:22: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:22: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:22:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:22:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:22: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:22: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:22: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:22: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:22: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:22: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:22:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:22: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:22: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:22: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:22: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:22: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:22: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:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:22:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:23 INFO - no previously-included directories found matching 'docs/_build' 05:22:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:22:23 INFO - Running setup.py install for pep8 05:22:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:23 INFO - no previously-included directories found matching 'docs/_build' 05:22:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:22:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:22:23 INFO - Cleaning up... 05:22:23 INFO - Return code: 0 05:22:23 INFO - Running post-action listener: _resource_record_post_action 05:22:23 INFO - Running post-action listener: _start_resource_monitoring 05:22:23 INFO - Starting resource monitoring. 05:22:23 INFO - ##### 05:22:23 INFO - ##### Running install step. 05:22:23 INFO - ##### 05:22:23 INFO - Running pre-action listener: _resource_record_pre_action 05:22:23 INFO - Running main action method: install 05:22:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:23 INFO - Reading from file tmpfile_stdout 05:22:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:22:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:22:24 INFO - Reading from file tmpfile_stdout 05:22:24 INFO - Output received: 05:22:24 INFO - Usage: mozinstall [options] installer 05:22:24 INFO - Options: 05:22:24 INFO - -h, --help show this help message and exit 05:22:24 INFO - -d DEST, --destination=DEST 05:22:24 INFO - Directory to install application into. [default: 05:22:24 INFO - "/builds/slave/test"] 05:22:24 INFO - --app=APP Application being installed. [default: firefox] 05:22:24 INFO - mkdir: /builds/slave/test/build/application 05:22:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:22:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:22:57 INFO - Reading from file tmpfile_stdout 05:22:57 INFO - Output received: 05:22:57 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:22:57 INFO - Running post-action listener: _resource_record_post_action 05:22:57 INFO - ##### 05:22:57 INFO - ##### Running run-tests step. 05:22:57 INFO - ##### 05:22:57 INFO - Running pre-action listener: _resource_record_pre_action 05:22:57 INFO - Running main action method: run_tests 05:22:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:22:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:22:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:22:57 INFO - 2016-03-30 05:22:57.934 screenresolution[1639:7411] starting screenresolution argv=screenresolution get 05:22:57 INFO - 2016-03-30 05:22:57.937 screenresolution[1639:7411] Display 0: 1600x1200x32@60 05:22:57 INFO - 2016-03-30 05:22:57.943 screenresolution[1640:7413] starting screenresolution argv=screenresolution list 05:22:57 INFO - Available Modes on Display 0 05:22:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:22:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:22:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:22:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:22:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:22:58 INFO - Intel Iris: 05:22:58 INFO - Chipset Model: Intel Iris 05:22:58 INFO - Type: GPU 05:22:58 INFO - Bus: Built-In 05:22:58 INFO - VRAM (Dynamic, Max): 1536 MB 05:22:58 INFO - Vendor: Intel (0x8086) 05:22:58 INFO - Device ID: 0x0a2e 05:22:58 INFO - Revision ID: 0x0009 05:22:58 INFO - Displays: 05:22:58 INFO - Display: 05:22:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:22:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:22:58 INFO - Display Serial Number: 1600x1200 60 05:22:58 INFO - Main Display: Yes 05:22:58 INFO - Mirror: Off 05:22:58 INFO - Online: Yes 05:22:58 INFO - Rotation: Supported 05:22:58 INFO - Return code: 0 05:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:58 INFO - Python 2.7.3 05:22:58 INFO - Return code: 0 05:22:58 INFO - grabbing minidump binary from tooltool 05:22: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:22:58 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 0x102972e00>, '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 0x1027dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10296db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:58 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:22:58 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:22:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:58 INFO - Return code: 0 05:22:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:22:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:22:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:22:59 INFO - Return code: 0 05:22:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0186 --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:22:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T6G6lLsCf1/Render', 05:22:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:59 INFO - 'HOME': '/Users/cltbld', 05:22:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:59 INFO - 'LOGNAME': 'cltbld', 05:22:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:59 INFO - 'MOZ_NO_REMOTE': '1', 05:22:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:59 INFO - 'NO_EM_RESTART': '1', 05:22:59 INFO - 'PAGER': '/bin/cat', 05:22:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:59 INFO - 'PWD': '/builds/slave/test', 05:22:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:59 INFO - 'SHELL': '/bin/bash', 05:22:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PrL5n2emwq/Listeners', 05:22:59 INFO - 'TMPDIR': '/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/', 05:22:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:59 INFO - 'USER': 'cltbld', 05:22:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:59 INFO - 'XPC_FLAGS': '0x0', 05:22:59 INFO - 'XPC_SERVICE_NAME': '0', 05:22:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0186', '--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:22:59 INFO - mozversion application_buildid: 20160330030326 05:22:59 INFO - mozversion application_changeset: d5d53a3b4e50b94cdf85d20690526e5a00d5b63e 05:22:59 INFO - mozversion application_display_name: Nightly 05:22:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:59 INFO - mozversion application_name: Firefox 05:22:59 INFO - mozversion application_remotingname: firefox 05:22:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:22:59 INFO - mozversion application_vendor: Mozilla 05:22:59 INFO - mozversion application_version: 48.0a1 05:22:59 INFO - mozversion platform_buildid: 20160330030326 05:22:59 INFO - mozversion platform_changeset: d5d53a3b4e50b94cdf85d20690526e5a00d5b63e 05:22:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:22:59 INFO - mozversion platform_version: 48.0a1 05:22:59 INFO - using testdate: 1459340579 05:22:59 INFO - actual date: 1459340579 05:22:59 INFO - starting webserver on 'localhost:49273' 05:22:59 INFO - SUITE-START | Running 2 tests 05:22:59 INFO - TEST-START | dromaeo_css 05:22:59 INFO - operating with platform_type : mac_ 05:22:59 INFO - Initialising browser for dromaeo_css test... 05:22:59 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpQc_GmW/profile http://localhost:49273/getInfo.html) 05:23:02 INFO - PROCESS | 1661 | JavaScript error: jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:23:03 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 05:23:03 INFO - PROCESS | 1661 | colorDepth:24 05:23:03 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 05:23:03 INFO - PROCESS | 1661 | __metrics 05:23:03 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 05:23:03 INFO - TEST-INFO | 1661: exit 0 05:23:03 INFO - Browser initialized. 05:23:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:23:03 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpQc_GmW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:15 INFO - PROCESS | 1666 | RSS: Main: 254775296 05:23:15 INFO - PROCESS | 1666 | 05:24:05 INFO - PROCESS | 1666 | 1459340645525 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:26:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 05:26:18 INFO - PROCESS | 1666 | RSS: Main: 271470592 05:26:18 INFO - PROCESS | 1666 | 05:29:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 05:29:21 INFO - PROCESS | 1666 | RSS: Main: 282394624 05:29:21 INFO - PROCESS | 1666 | 05:32:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 05:32:23 INFO - PROCESS | 1666 | RSS: Main: 284385280 05:32:23 INFO - PROCESS | 1666 | 05:35:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 05:35:25 INFO - PROCESS | 1666 | RSS: Main: 285937664 05:35:25 INFO - PROCESS | 1666 | 05:38:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 05:38:28 INFO - PROCESS | 1666 | RSS: Main: 288780288 05:38:28 INFO - PROCESS | 1666 | 05:41:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 05:41:31 INFO - PROCESS | 1666 | RSS: Main: 290140160 05:41:31 INFO - PROCESS | 1666 | 05:41:31 INFO - PROCESS | 1666 | __start_tp_report 05:41:31 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:41:31 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:41:31 INFO - PROCESS | 1666 | |i|pagename|runs| 05:41:31 INFO - PROCESS | 1666 | |0;dojo.html;2971.598834157389;3196.5684632574603;3595.352836489431;3610.8916732498033;3669.284489524544;5063.7974481020765;5360.973195134024;5793.942060579393;5941.613795103321;5946.762129514815;5774.682392468412;5966.552508561854;6032.0951857221435;6064.484518815895;6083.178770865932;5261.579073674096;5265.449938635731;5340.759665815028;5360.624756267063;5423.593230507708;4833.340538671046;5364.839054828361;5427.592930530226;5436.619436639437;5489.835304940858;5290.312259406291;5357.624966252364;5367.302250707383;5406.162044883049;5407.702576358299;5297.867553311159;5330.600204984603;5345.625806193568;5373.086575282211;5374.274472946141;5291.523762861322;5297.364316282033;5335.813246536352;5345.438728933484;5358.732063396815;5616.297962754656;5697.4587414195585;5797.855053623651;5897.498712609433;5911.054231322968;6208.689565521751;6238.87522249557;6265.997440409558;6266.49868010558;6268.373162683741;6291.465225455841;6306.180196574416;6306.684665766693;6323.336049714806;6330.430261276461;5890.852728681817;5965.821025369246;6053.636781793107;6054.96972515139;6129.754809807558;6317.4946004319545;6402.679866006681;6409.102725618417;6414.198225221848;6470.22357317125;6283.654399008098;6295.811125666238;6310.400511951358;6311.526635502356;6315.431611154926;6104.7926496150985;6210.223722034746;6238.438540531374;6282.654454005074;6300.180976473121;6147.139400483936;6186.381361863778;6252.062190671345;6260.655663938527;6266.905996410058;5730.914036289459;6034.366391528914;6035.702324000361;6193.67181311375;6248.812535623939;4308.569143085729;4828.396450443694;4970.577500912391;5021.14640511114;5091.465396133427;4485.25993211123;4497.64018878489;4513.954860451419;4539.7049191802425;4565.589096981287;5987.221661184019;6028.9397106029255;6033.396660333931;6064.36324185963;6074.119252708421;5292.497212764782;6176.567640265138;6268.811935641938;6274.780382686676;6316.536550745213;4974.651774375759;5490.764577970005;6031.5476339273855;6063.605865618809;6066.090086486974;5247.868803279948;5401.675899446046;5510.862228444321;5555.472230138131;5564.610477266552;5641.5204707600315;6498.805035848932;6534.117894084333;6540.084388185563;6550.47596192313;5295;6309.085182648582;6309.652969086745;6322.083297921868;6330.778422755181;6241.875162496815;6375.936240637534;6473.902891456726;6488.383603557654;6498.220213574401;6158.630482171084;6219.595726277777;6273.466755325849;6290.056491526308;6293.685315734104;6163.660998644938;6260.436560709558;6288.842778930563;6366.076918846834;6372.458341041063;5165.845024649267;6042.395760424099;6132.724027418688;6230.252369715663;6236.407541283571;6109.43503133753;6147.415995480422;6183.598066125687;6187.102870083722;6189.690515474118;6046.89489849434;6101.7559297627595;6113.663748493697;6168.35232300602;6193.81418557444;6106.969465152823;6107.816765497042;6160.568760186744;6276.152719383008;6279.748810047729;6097.591277512581;6114.877702445837;6117.522930757332;6123.171248411065;6153.4154255345675 05:41:31 INFO - PROCESS | 1666 | |1;ext.html;437.97076869357016;560.3667855323483;589.1339730596023;590.4715279824558;599.3497055694571;36703;37083.072923176864;37198.90812010677;37455.81272093639;37472.81263593678;38756;39165.608343916625;39200.01999949996;39317.60682393183;39489;9349.158575728201;9569.09093636107;9595.568199431007;9607.66373176939;9622.615095396175;9412.529373531295;9618.470984095871;9666.27502937279;9676.467794271312;9720;8315.459495132827;9646.710598682052;9717.562709678046;9717.562709678046;9735.561899714494;9648.421094734304;9687.854682179774;9688;9704.223662107015;9723.27075469339;9441.622335106587;9516.857247141299;9572.090651388107;9586.90413095867;9588.041195880425;37689.434658480146;38080.80959595184;38112.61887381118;38212.42681359782;38293.42559861604;2753.490604238222;3275.5250488679008;3463.3592785334795;3482.89551313461;3826.5025546678753;28544.143675689764;28957.85521072381;29571;29574.556381654293;29739.405211895857;2703.9729602704115;2803.495370833249;2854.0866922584783;2856.3573196030725;2959.393324368499;406935;413895;416219;416631.9168404169;417729;68213.65893170502;73301;73523;73564;73882;66430.33569664338;78804.60597696975;78899.21100789034;80471.7929231062;80540.19459805444;17328.48014559565;17463.650726985645;17557.122143892753;17557.473275801745;17614.03122828231;12889.742205156032;13055.543055992996;13114.01644876638;13197.142185758086;13208.801867971988;22791.202307919142;22836.515626484226;22934;23020.19429319999;23243.418914527272;8095.595220238964;9492.477913714674;9778.65774697882;9823.950880245553;9841.360311579725;846.7925358287259;973.4889183178747;980.8675828763169;1088.6679562733443;1161.5005547614608;26522.602160967603;28524.42951141007;28804.71195288062;29257.97597084092;29414;1033.1837848099917;1054.177741361739;1118.1725523113;1118.5861231344293;1123.4438952718294;14303.21332326732;14522.419103235963;14570.635734106732;14600.561983140522;14848.96057276002;481590;481936;485657;488784;501903;57905.71047144822;58052.12921806176;58137.127943080886;58534.707326463096;58577.828443430895;1409.5912185466304;1436.3751767980962;1461.3862177885314;1470.4559313054237;1471.1026273972868;22223.666645000016;27322.36065836056;28239.15282541527;28884.855575721987;29175.854120729262;48614.27078593895;49616.75191624019;50109.498905010485;50310.49689503205;50433.74783126061;464604;467030;467690;468426;471582;33729.988100357026;33930.66069339275;34543;43748.56251437445;44852.77573612111;42026.94932626709;42270.36594451024;42602.57397425986;42877.356839648055;43305.56694433015;27829;28041.71958280391;28058.158255252376;28320;28483;36206.91379258627;37698.62301377061;38570.228595427376;39431.408528872664;39470.40794388144;35696;36425;36934.63065369419;37477.43783843299;37601.62398375981;31267;31958.041258762274;32557.34885302328;33186.83406582951;33329.166770830925;19851.702224466357;21494.140234391074;24757;25269.87365063163;25349.619755704047 05:41:31 INFO - PROCESS | 1666 | |2;jquery.html;354.10764872521247;361.4650317530055;367.37729548415433;368.9501917241172;370.5793923896377;17238.0519071451;19441.805581944194;19596.412107636777;20393.980300984927;20658.89670551647;20536.691949620767;20895.373138805822;21052.368428947117;21085.894570527125;21278;5722.914156287659;5863.179154918314;5920.378360272174;5932.228810254661;5951.6429014259065;3977.2244412339605;5295.708736019517;6179.62922224668;6442.581232219914;6457.3865482779065;6328.841778955517;6375.3943375379495;6389.520785941073;6401.16784817973;6401.967990160043;6016.669083200422;6275.592086514362;6276.246850377984;6279.623222606635;6283.968580157116;5157;5394.703291318976;5442.809501667422;5444.754986025639;5452.727363631802;22723.318300451014;23685;24430.877845610838;24514.509709805883;24899.875500622562;1911.9330823421114;2043.795620437959;2061.9690704639443;2262.6832243485924;2453.5338285725657;9512.857307140399;9595.568199431042;9743.123118919331;9761;9788.706338809847;1468.3759402254107;1733.1507561295;1757.4464043826154;1831.5878927241397;1857.8327950484386;88005.07954284146;94369;102856;106372.46813765881;107043.92956070496;9232.307576931622;10980.505877235544;11042.668719938414;11078.944605276922;11196.720081997852;12985.480580776852;13433.932830335785;13593.116447430886;13642.658933526543;13660.453581856813;8460.153984601491;8718.302535797122;8744.562771861381;8769.824603507894;8809.515476648847;8929.776755581162;8942.597583108776;8946.507942063248;8956.955215223883;8964.551772411483;4188.350805625133;4382.715123516961;4412.161689279027;4468.776561171929;4482.372467854503;1775.8934463932205;1830.9542261443305;1851.5000949743762;1879.821416965386;1921.269917431367;899.1098812175899;904.737626088427;951.3911096897991;964.9565769540387;1008.9394636321697;13817.240051797047;17722;18959.672822902263;20102.798972010387;20284.898575507028;914.4421902639384;927.3462209142539;967.7532229281488;1006.2101250518308;1021.7139201023725;10701.357918524913;10821.458927053773;10824;10861.728456788644;10917.39954302505;601886.9716954249;604077;606580;610217;639545;110531.44734276277;115153;116060.41969790097;118854;120522;999.5252255178877;1000.9699709008742;1014.5688082564881;1018.9184865210765;1035.4460363705532;17643.55891102733;17723.46829595114;17842.01868897171;17892.46322610324;17932.91033544876;31886.681133188373;32429.837850810596;48054.55836324916;50083.99832003412;50317.74841125771;69885.95171072539;71252;72120.9181862262;72239.63880180566;73975.63012184904;7391.2978267064545;7486.401087912845;7520.172780993977;7528.774136775905;7795.064592248967;9826.705198844045;11922.105842062054;11967.222130561486;12065.09511786602;12225.69435764113;10311.690649280534;10501.737456563647;10537.157027437634;10589.894101058891;10629;10243.129334006693;10260.281780275309;10315.329503582243;10496.16030717556;10643.680689579325;8793.780155496164;9149.451032938045;10554.525046373084;10616.84074738895;10901.945490272497;7420.146683131293;7446.962765186356;7519.511231769918;7706.036745406825;7767.883481747665;8017.478863873829;8284.751457456287;10486.947565262124;10503.842442363524;10671.679849604525 05:41:31 INFO - PROCESS | 1666 | |3;mootools.html;1438.510906291861;1634.1584084196636;1801.8288262615047;1880.7178923161523;1896.4500294914485;7085.397741192005;7321.926780732191;7956.840863182733;8885.200331970122;8974.102589741022;7309.780706578797;8740.606672699729;8803.911960880389;8825.117488251171;8830.60262288197;2095.7904209579033;2502.674652295199;2529.29179829648;2534.4424226670194;2535.3408113890337;2033.7356143701297;2432.52565749678;2502.5745623244;2513.3842208658903;2516.7986561075163;2490.489449662815;2495.5757521221344;2501.9749802501924;2520.243926821955;2523.8611876346795;2445.425325048612;2452.681151450309;2452.730199678034;2498.6626805381406;2523;2462.1628646260356;2486.465409936872;2494;2495.238952119603;2534.0750626021554;8873.600687969058;8919.79582756326;8961.507117108556;8968.820623587557;8984.640614375417;5516.200150978126;5553.278073850373;5603.775848966036;5606.467385598362;5655.953648575027;3634.800085995269;3711.109333759905;3776.6412190841825;3783.129880127586;3788.753731007503;1025.5692609104194;1036.1865935240876;1036.7719101797593;1039.1790485516433;1040.3653771199563;12237.938810305892;12314.938425307817;12351.752964940652;12361.196522226026;12379.762023797548;4924;4967.230079337708;4970.701757894538;5011.599072074226;5036.622253331015;10081.243906707026;10111.544980475895;10143.28996970205;10385.480725963671;10387.584496620202;5448.128299472065;5566.944330556643;5583.413741557078;5614.326280846324;5638.746256418471;4506.887327816765;4862.5380588844;4935.333729946411;4950.777215025332;5068.315777370081;3882.2235552889533;3916.3146449371247;3972.483577134954;3978.0452691353867;4000.739951903117;1321.4053675845907;1325.4101924643635;1326.9800952985713;1333.999500374719;1340.1088276296348;1091.5851976248975;1123.5674265407877;1311.1477539599337;1399.6081097292774;1405.7891316302637;7946.006749156356;8086.595670216466;8095;8110.716124935599;8119.228673276029;451.4988362917159;528.9444608316148;537.7284471342025;1194.9283043017447;1276.6489215465635;6316.557840951181;6344.175257216532;6398.904016439664;6416.711247993851;6422.068800023971;10623;10685.038346548848;10721.249512534048;10991.835122473169;10999.450027498753;10424.061834434937;10862.565497380174;10912.727181820359;10943.23397362193;11010.119190464744;8340.41617086798;8343.290820280345;8387.203215694499;8439;8490.915090849136;7903.328217101611;7904.881426778488;7937.484063535851;7974.601269936596;8071.434999549975;9826.263030272616;9861.865885423269;9873.703788886345;9964.352317099365;9980;9939.453330066915;10040.640449494509;10352.430616315874;10360.948195258976;10426.68719938403;6522.706478208587;6935.410490108397;6973.79078627642;7137;7172.246914073947;8348.33213342919;8351.997760268563;8395.370347223861;8433.704820331504;8457.36569757283;7196.748113815991;7353;7486.625668716433;7575.090989081125;7605.163432022362;7118.85762284741;7197.244289349753;7207.13514378278;7221.8084016136745;7228.9277107230355;7705.730299439493;7786.377089832687;7884;7889.684412623431;7944.093417579855;7061.364477197077;7064.576125432285;7136.821579460555;7138.46461515378;7140.750073747394;7197.748078817216;7270.200277969313;7282.380997615051;7328.853422931618;7370.889436658562 05:41:31 INFO - PROCESS | 1666 | |4;prototype.html;329.70656116056716;330.2338574507143;335.9798412095276;338.2069048082247;343.66492669647096;5613.7473813678325;7008.719651213958;7060.717571297142;7062.5056246062795;7069.929300706991;5545.500904918556;6928.445724342053;6971.337722916315;6973.686184121714;7019.157701075866;4856.417229932413;4956.355673762406;5065.873353166164;5089.694618322894;5134.845954621367;5062.987402519492;5088.643794934356;5111.565516931066;5114.872128196787;5126.128558145106;5049.722265275408;5050.646454748169;5051.469595692454;5060.316857224283;5067.569256613174;5050.696958182521;5057.5701065409485;5059.418166910816;5068;5087.745612719368;4340.761258130801;4351.064521127941;4351.216780979423;4364;4389.692721509464;6487.22153341602;6682.164729408824;6711.228208755958;6730.9903514472735;6762.492813038993;5907.616004959664;5957.076653118774;5997.250343707036;6004.949133901549;6009.278886533644;7448;7455.291747283999;7462.141853686841;7468.813279667997;7492.36314913233;4067.1865626874446;4892.094962431962;4900.6569540132205;4908.410990681141;4922.827701030446;7126.786196414116;7883.211678832128;7888.881666774945;7895.210478952059;7903.051633803922;4892.119418504632;4949.158643030693;4967.776450059756;4980;4989.226669866177;5061.316722242524;5062.265971434122;5070.847874563769;5081.0854046272025;5093.777493401557;4858.222684370484;5976.073708575178;6018.247719035121;6044.576879618472;6046.939530604725;7540.359069479046;7547.28300811422;7560.886586701204;7573.810654733566;7575.053118360205;1677.8154403015658;1734.072271334855;1737.843594076514;1760.700680884227;1777.6355847051323;1011.8482227665909;1110.4780753046055;1135.5571327182406;1138.385271953136;1145.7823013627385;6817.147856517935;6881.759138430231;6903.344182302673;6925.896111558331;6935.653217339112;7694.153643099255;7695.730649427243;7751.302382785464;7774.105977812511;7793.844123117506;6924.4114250289285;6933.064036355027;6954.617496037767;6959.234484206733;6968.547044442095;3346.5314855919705;3815.6184381562175;4056.14820887611;4106.650934670586;4112.897177570585;7981.800454988672;8105.1084380718075;8109.432339736162;8118.35053195743;8127.674893004214;8159.67361305553;8163.95918020418;8174.468659537111;8186.590670466453;8198.38512111594;6736.461083113241;8098.068722096917;8223.05434874997;8223.259906608433;8258.628361723737;7647.885281720667;7800.141984381827;7803.258690424627;7897.723579674684;7921.564313962557;6759.86480270382;7245.616402076878;7742;7754.030746156731;7782.416318776001;8167;8175.7138500152205;8180.46826956246;8183.181681831769;8195.508269503849;4147.2534943709215;5041.495850414929;5043.420006699276;5050.494950505067;5065.265536497113;6328.272248691459;7196.2009497625595;7528.774136775905;7814.4529882907655;7850.960745196237;6439.227292724903;6831.316868313129;6850.212225593921;7510.586917719359;7512.060992375953;7518.518888766804;7520.736774212876;7535.208803075599;7543.698252069856;7558;7106.289371063059;7375.889361659472;7391.556506609621;7403.851922961619;7408.518446300973;6838.418734407631;7533.773986780406;7561.962190189014;7563;7569.6593653284635;6500.25247096571;6938.230751158422;7281.963590182015;7293.708251669874;7384.741534046282 05:41:31 INFO - PROCESS | 1666 | |5;yui.html;672.3075232510514;720.7369310201778;749.9362554182894;753.604357712201;759.6493315879245;14448.349824257908;14632.4878629248;14739.263036848168;14749.557513274605;14765.114093154418;13687.863121368784;13729.931350343259;13754.243516606582;13773.51792687256;13798.655033624165;728.9854202915939;901.2384535067857;913.9086091390874;916.038159932072;940.8165407745493;891.6210610490548;922.0134456131908;929.2101713543501;930.1210356213381;930.9394889332171;924.8566472196786;951.4243882451121;963.5134257200104;965.2374624046995;967.4243824924159;918.4948278446861;941.9152276295132;947.2422062350092;955.2262667239559;961.942283462991;696.4985210648325;697.1425147069133;708.4155571653355;709.4359983812881;728.8250819803262;14480.986330956837;14484.855151448455;14524.055936364208;14663.63340916475;14780.187089710062;12438.937805311007;12441.440135193938;12580.43388047531;12768.361581920866;12873.67815804603;9841.311108222428;9947;10015.59937602495;10070.597176112946;10299.588016479333;3479.599846017715;3511.841967111486;3513.332466831294;3514.6485351464903;3522.5772907251294;83818;84893.3021339576;86755.13244867534;86876;87098.25803483959;8467.36494762883;9469.063545150508;9504.192143667728;9542.188913942255;9580.329376943686;20550.58898822015;20801.479963000744;20939.267125650527;20952;20957.68563471549;6396.648184349905;6412.134361861183;6506.512011599149;6506.739730410731;6516.837079073061;4028.5568587455355;4058.492688413948;4165.291900376943;4180.874573762792;4198.517170525429;3580.820958952042;3589.353916295092;3613.9096522587147;3614.945775813312;3627.764195327295;656.3108735827362;661.7154623511937;662.2053535757111;670.7149461478851;671.362205904383;485.1727804094011;535.7669413804929;563.7265926025874;585.1982783586514;612.8437248501692;8018.238267364591;8216.835663286702;8293.792655183548;8296.8340633187;8406.118948714658;480.1549273278984;536.2546060975247;537.5941164420838;591.4263164730205;606.0696830365368;3202.0553936588763;3235.5793746813233;3469.5663042119736;3806.218019689372;3828.1960788234783;92185;92674.60988085184;94086;94669;95361.0463895366;78170.6091469539;78171;78600.6069969658;79543.80684289741;80863;67842.98235526372;69005;70446.64776676084;71226.6438667793;71877;7725.072991241087;7929.405294603043;7939.761807145795;8002.7199048033035;8229.300509456763;51129;52087.21869172041;52225.21662174995;52268.73865630647;52426.42720718384;65558;67496.32503674901;68448.63102738016;72091.90191429107;72139.27860721535;9868.407895526292;9893.208543316374;9980.850287245552;10216.131628811634;10400.791984160123;9324;10817.675469735921;10852.131829453467;10886.23796334249;10994.945025274823;8798.472091674264;10355.119814815524;10355.482225888525;10531.631392901212;10839.620613278497;10141.898581014095;10370.948145259526;10482.780482730988;10775.976282253174;11316.15128865322;8533.786655333666;9095.317851161057;9745.707628771148;9792.461414622265;10125.797484050425;8684.261837743863;8763.693270735494;9750.658726944523;9875.259355548218;9905.257105716955;9487.715368538955;9673.274504412339;9732.854007190039;9735.805283894424;9760.072793084646 05:41:31 INFO - PROCESS | 1666 | __end_tp_report 05:41:31 INFO - PROCESS | 1666 | __start_cc_report 05:41:31 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,376 05:41:31 INFO - PROCESS | 1666 | __end_cc_report 05:41:31 INFO - PROCESS | 1666 | __startTimestamp1459341691506__endTimestamp 05:41:31 INFO - PROCESS | 1666 | 05:41:31 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:41:31 INFO - PROCESS | 1666 | Number of tests: 6 05:41:31 INFO - PROCESS | 1666 | 05:41:31 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5814.74 Median:6083.18 stddev:658.26 (10.8%) stddev-sans-first:621.35 05:41:31 INFO - PROCESS | 1666 | Values: 2971.6 3196.6 3595.4 3610.9 3669.3 5063.8 5361.0 5793.9 5941.6 5946.8 5774.7 5966.6 6032.1 6064.5 6083.2 5261.6 5265.4 5340.8 5360.6 5423.6 4833.3 5364.8 5427.6 5436.6 5489.8 5290.3 5357.6 5367.3 5406.2 5407.7 5297.9 5330.6 5345.6 5373.1 5374.3 5291.5 5297.4 5335.8 5345.4 5358.7 5616.3 5697.5 5797.9 5897.5 5911.1 6208.7 6238.9 6266.0 6266.5 6268.4 6291.5 6306.2 6306.7 6323.3 6330.4 5890.9 5965.8 6053.6 6055.0 6129.8 6317.5 6402.7 6409.1 6414.2 6470.2 6283.7 6295.8 6310.4 6311.5 6315.4 6104.8 6210.2 6238.4 6282.7 6300.2 6147.1 6186.4 6252.1 6260.7 6266.9 5730.9 6034.4 6035.7 6193.7 6248.8 4308.6 4828.4 4970.6 5021.1 5091.5 4485.3 4497.6 4514.0 4539.7 4565.6 5987.2 6028.9 6033.4 6064.4 6074.1 5292.5 6176.6 6268.8 6274.8 6316.5 4974.7 5490.8 6031.5 6063.6 6066.1 5247.9 5401.7 5510.9 5555.5 5564.6 5641.5 6498.8 6534.1 6540.1 6550.5 5295.0 6309.1 6309.7 6322.1 6330.8 6241.9 6375.9 6473.9 6488.4 6498.2 6158.6 6219.6 6273.5 6290.1 6293.7 6163.7 6260.4 6288.8 6366.1 6372.5 5165.8 6042.4 6132.7 6230.3 6236.4 6109.4 6147.4 6183.6 6187.1 6189.7 6046.9 6101.8 6113.7 6168.4 6193.8 6107.0 6107.8 6160.6 6276.2 6279.7 6097.6 6114.9 6117.5 6123.2 6153.4 05:41:31 INFO - PROCESS | 1666 | 05:41:31 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:61183.31 Median:21059.96 stddev:121460.76 (576.7%) stddev-sans-first:121715.86 05:41:31 INFO - PROCESS | 1666 | Values: 438.0 560.4 589.1 590.5 599.3 36703.0 37083.1 37198.9 37455.8 37472.8 38756.0 39165.6 39200.0 39317.6 39489.0 9349.2 9569.1 9595.6 9607.7 9622.6 9412.5 9618.5 9666.3 9676.5 9720.0 8315.5 9646.7 9717.6 9717.6 9735.6 9648.4 9687.9 9688.0 9704.2 9723.3 9441.6 9516.9 9572.1 9586.9 9588.0 37689.4 38080.8 38112.6 38212.4 38293.4 2753.5 3275.5 3463.4 3482.9 3826.5 28544.1 28957.9 29571.0 29574.6 29739.4 2704.0 2803.5 2854.1 2856.4 2959.4 406935.0 413895.0 416219.0 416631.9 417729.0 68213.7 73301.0 73523.0 73564.0 73882.0 66430.3 78804.6 78899.2 80471.8 80540.2 17328.5 17463.7 17557.1 17557.5 17614.0 12889.7 13055.5 13114.0 13197.1 13208.8 22791.2 22836.5 22934.0 23020.2 23243.4 8095.6 9492.5 9778.7 9824.0 9841.4 846.8 973.5 980.9 1088.7 1161.5 26522.6 28524.4 28804.7 29258.0 29414.0 1033.2 1054.2 1118.2 1118.6 1123.4 14303.2 14522.4 14570.6 14600.6 14849.0 481590.0 481936.0 485657.0 488784.0 501903.0 57905.7 58052.1 58137.1 58534.7 58577.8 1409.6 1436.4 1461.4 1470.5 1471.1 22223.7 27322.4 28239.2 28884.9 29175.9 48614.3 49616.8 50109.5 50310.5 50433.7 464604.0 467030.0 467690.0 468426.0 471582.0 33730.0 33930.7 34543.0 43748.6 44852.8 42026.9 42270.4 42602.6 42877.4 43305.6 27829.0 28041.7 28058.2 28320.0 28483.0 36206.9 37698.6 38570.2 39431.4 39470.4 35696.0 36425.0 36934.6 37477.4 37601.6 31267.0 31958.0 32557.3 33186.8 33329.2 19851.7 21494.1 24757.0 25269.9 25349.6 05:41:31 INFO - PROCESS | 1666 | 05:41:31 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:33772.70 Median:16391.97 stddev:101442.17 (618.9%) stddev-sans-first:101695.71 05:41:31 INFO - PROCESS | 1666 | Values: 354.1 361.5 367.4 369.0 370.6 17238.1 19441.8 19596.4 20394.0 20658.9 20536.7 20895.4 21052.4 21085.9 21278.0 5722.9 5863.2 5920.4 5932.2 5951.6 3977.2 5295.7 6179.6 6442.6 6457.4 6328.8 6375.4 6389.5 6401.2 6402.0 6016.7 6275.6 6276.2 6279.6 6284.0 5157.0 5394.7 5442.8 5444.8 5452.7 22723.3 23685.0 24430.9 24514.5 24899.9 1911.9 2043.8 2062.0 2262.7 2453.5 9512.9 9595.6 9743.1 9761.0 9788.7 1468.4 1733.2 1757.4 1831.6 1857.8 88005.1 94369.0 102856.0 106372.5 107043.9 9232.3 10980.5 11042.7 11078.9 11196.7 12985.5 13433.9 13593.1 13642.7 13660.5 8460.2 8718.3 8744.6 8769.8 8809.5 8929.8 8942.6 8946.5 8957.0 8964.6 4188.4 4382.7 4412.2 4468.8 4482.4 1775.9 1831.0 1851.5 1879.8 1921.3 899.1 904.7 951.4 965.0 1008.9 13817.2 17722.0 18959.7 20102.8 20284.9 914.4 927.3 967.8 1006.2 1021.7 10701.4 10821.5 10824.0 10861.7 10917.4 601887.0 604077.0 606580.0 610217.0 639545.0 110531.4 115153.0 116060.4 118854.0 120522.0 999.5 1001.0 1014.6 1018.9 1035.4 17643.6 17723.5 17842.0 17892.5 17932.9 31886.7 32429.8 48054.6 50084.0 50317.7 69886.0 71252.0 72120.9 72239.6 73975.6 7391.3 7486.4 7520.2 7528.8 7795.1 9826.7 11922.1 11967.2 12065.1 12225.7 10311.7 10501.7 10537.2 10589.9 10629.0 10243.1 10260.3 10315.3 10496.2 10643.7 8793.8 9149.5 10554.5 10616.8 10901.9 7420.1 7447.0 7519.5 7706.0 7767.9 8017.5 8284.8 10486.9 10503.8 10671.7 05:41:31 INFO - PROCESS | 1666 | 05:41:31 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:6111.13 Median:5052.47 stddev:3243.76 (64.2%) stddev-sans-first:3233.85 05:41:31 INFO - PROCESS | 1666 | Values: 1438.5 1634.2 1801.8 1880.7 1896.5 7085.4 7321.9 7956.8 8885.2 8974.1 7309.8 8740.6 8803.9 8825.1 8830.6 2095.8 2502.7 2529.3 2534.4 2535.3 2033.7 2432.5 2502.6 2513.4 2516.8 2490.5 2495.6 2502.0 2520.2 2523.9 2445.4 2452.7 2452.7 2498.7 2523.0 2462.2 2486.5 2494.0 2495.2 2534.1 8873.6 8919.8 8961.5 8968.8 8984.6 5516.2 5553.3 5603.8 5606.5 5656.0 3634.8 3711.1 3776.6 3783.1 3788.8 1025.6 1036.2 1036.8 1039.2 1040.4 12237.9 12314.9 12351.8 12361.2 12379.8 4924.0 4967.2 4970.7 5011.6 5036.6 10081.2 10111.5 10143.3 10385.5 10387.6 5448.1 5566.9 5583.4 5614.3 5638.7 4506.9 4862.5 4935.3 4950.8 5068.3 3882.2 3916.3 3972.5 3978.0 4000.7 1321.4 1325.4 1327.0 1334.0 1340.1 1091.6 1123.6 1311.1 1399.6 1405.8 7946.0 8086.6 8095.0 8110.7 8119.2 451.5 528.9 537.7 1194.9 1276.6 6316.6 6344.2 6398.9 6416.7 6422.1 10623.0 10685.0 10721.2 10991.8 10999.5 10424.1 10862.6 10912.7 10943.2 11010.1 8340.4 8343.3 8387.2 8439.0 8490.9 7903.3 7904.9 7937.5 7974.6 8071.4 9826.3 9861.9 9873.7 9964.4 9980.0 9939.5 10040.6 10352.4 10360.9 10426.7 6522.7 6935.4 6973.8 7137.0 7172.2 8348.3 8352.0 8395.4 8433.7 8457.4 7196.7 7353.0 7486.6 7575.1 7605.2 7118.9 7197.2 7207.1 7221.8 7228.9 7705.7 7786.4 7884.0 7889.7 7944.1 7061.4 7064.6 7136.8 7138.5 7140.8 7197.7 7270.2 7282.4 7328.9 7370.9 05:41:31 INFO - PROCESS | 1666 | 05:41:31 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:6080.74 Median:6865.99 stddev:1970.19 (28.7%) stddev-sans-first:1927.86 05:41:31 INFO - PROCESS | 1666 | Values: 329.7 330.2 336.0 338.2 343.7 5613.7 7008.7 7060.7 7062.5 7069.9 5545.5 6928.4 6971.3 6973.7 7019.2 4856.4 4956.4 5065.9 5089.7 5134.8 5063.0 5088.6 5111.6 5114.9 5126.1 5049.7 5050.6 5051.5 5060.3 5067.6 5050.7 5057.6 5059.4 5068.0 5087.7 4340.8 4351.1 4351.2 4364.0 4389.7 6487.2 6682.2 6711.2 6731.0 6762.5 5907.6 5957.1 5997.3 6004.9 6009.3 7448.0 7455.3 7462.1 7468.8 7492.4 4067.2 4892.1 4900.7 4908.4 4922.8 7126.8 7883.2 7888.9 7895.2 7903.1 4892.1 4949.2 4967.8 4980.0 4989.2 5061.3 5062.3 5070.8 5081.1 5093.8 4858.2 5976.1 6018.2 6044.6 6046.9 7540.4 7547.3 7560.9 7573.8 7575.1 1677.8 1734.1 1737.8 1760.7 1777.6 1011.8 1110.5 1135.6 1138.4 1145.8 6817.1 6881.8 6903.3 6925.9 6935.7 7694.2 7695.7 7751.3 7774.1 7793.8 6924.4 6933.1 6954.6 6959.2 6968.5 3346.5 3815.6 4056.1 4106.7 4112.9 7981.8 8105.1 8109.4 8118.4 8127.7 8159.7 8164.0 8174.5 8186.6 8198.4 6736.5 8098.1 8223.1 8223.3 8258.6 7647.9 7800.1 7803.3 7897.7 7921.6 6759.9 7245.6 7742.0 7754.0 7782.4 8167.0 8175.7 8180.5 8183.2 8195.5 4147.3 5041.5 5043.4 5050.5 5065.3 6328.3 7196.2 7528.8 7814.5 7851.0 6439.2 6831.3 6850.2 7510.6 7512.1 7518.5 7520.7 7535.2 7543.7 7558.0 7106.3 7375.9 7391.6 7403.9 7408.5 6838.4 7533.8 7562.0 7563.0 7569.7 6500.3 6938.2 7282.0 7293.7 7384.7 05:41:31 INFO - PROCESS | 1666 | 05:41:31 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18336.93 Median:34084.32 stddev:26462.10 (77.6%) stddev-sans-first:26503.09 05:41:31 INFO - PROCESS | 1666 | Values: 672.3 720.7 749.9 753.6 759.6 14448.3 14632.5 14739.3 14749.6 14765.1 13687.9 13729.9 13754.2 13773.5 13798.7 729.0 901.2 913.9 916.0 940.8 891.6 922.0 929.2 930.1 930.9 924.9 951.4 963.5 965.2 967.4 918.5 941.9 947.2 955.2 961.9 696.5 697.1 708.4 709.4 728.8 14481.0 14484.9 14524.1 14663.6 14780.2 12438.9 12441.4 12580.4 12768.4 12873.7 9841.3 9947.0 10015.6 10070.6 10299.6 3479.6 3511.8 3513.3 3514.6 3522.6 83818.0 84893.3 86755.1 86876.0 87098.3 8467.4 9469.1 9504.2 9542.2 9580.3 20550.6 20801.5 20939.3 20952.0 20957.7 6396.6 6412.1 6506.5 6506.7 6516.8 4028.6 4058.5 4165.3 4180.9 4198.5 3580.8 3589.4 3613.9 3614.9 3627.8 656.3 661.7 662.2 670.7 671.4 485.2 535.8 563.7 585.2 612.8 8018.2 8216.8 8293.8 8296.8 8406.1 480.2 536.3 537.6 591.4 606.1 3202.1 3235.6 3469.6 3806.2 3828.2 92185.0 92674.6 94086.0 94669.0 95361.0 78170.6 78171.0 78600.6 79543.8 80863.0 67843.0 69005.0 70446.6 71226.6 71877.0 7725.1 7929.4 7939.8 8002.7 8229.3 51129.0 52087.2 52225.2 52268.7 52426.4 65558.0 67496.3 68448.6 72091.9 72139.3 9868.4 9893.2 9980.9 10216.1 10400.8 9324.0 10817.7 10852.1 10886.2 10994.9 8798.5 10355.1 10355.5 10531.6 10839.6 10141.9 10370.9 10482.8 10776.0 11316.2 8533.8 9095.3 9745.7 9792.5 10125.8 8684.3 8763.7 9750.7 9875.3 9905.3 9487.7 9673.3 9732.9 9735.8 9760.1 05:41:31 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:41:31 INFO - PROCESS | 1666 | 05:41:32 INFO - TEST-INFO | 1666: exit 0 05:41:32 INFO - TEST-OK | dromaeo_css | took 1112192ms 05:41:32 INFO - TEST-START | kraken 05:41:32 INFO - operating with platform_type : mac_ 05:41:32 INFO - Initialising browser for kraken test... 05:41:32 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpr6U2W2/profile http://localhost:49273/getInfo.html) 05:41:34 INFO - PROCESS | 1675 | JavaScript error: jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:41:35 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 05:41:35 INFO - PROCESS | 1675 | colorDepth:24 05:41:35 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 05:41:35 INFO - PROCESS | 1675 | __metrics 05:41:35 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 05:41:35 INFO - TEST-INFO | 1675: exit 0 05:41:35 INFO - Browser initialized. 05:41:35 INFO - Running cycle 1/1 for kraken test... 05:41:35 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/T/tmpr6U2W2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:47 INFO - PROCESS | 1679 | RSS: Main: 254316544 05:41:47 INFO - PROCESS | 1679 | 05:41:50 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:51 INFO - PROCESS | 1679 | RSS: Main: 266862592 05:41:51 INFO - PROCESS | 1679 | 05:41:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 05:41:54 INFO - PROCESS | 1679 | RSS: Main: 275718144 05:41:54 INFO - PROCESS | 1679 | 05:41:57 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 05:41:58 INFO - PROCESS | 1679 | RSS: Main: 279158784 05:41:58 INFO - PROCESS | 1679 | 05:42:00 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 05:42:00 INFO - PROCESS | 1679 | RSS: Main: 280100864 05:42:00 INFO - PROCESS | 1679 | 05:42:02 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:42:03 INFO - PROCESS | 1679 | RSS: Main: 280567808 05:42:03 INFO - PROCESS | 1679 | 05:42:06 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 05:42:07 INFO - PROCESS | 1679 | RSS: Main: 282144768 05:42:07 INFO - PROCESS | 1679 | 05:42:10 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 05:42:10 INFO - PROCESS | 1679 | RSS: Main: 281759744 05:42:10 INFO - PROCESS | 1679 | 05:42:13 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 05:42:14 INFO - PROCESS | 1679 | RSS: Main: 281858048 05:42:14 INFO - PROCESS | 1679 | 05:42:15 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:42:16 INFO - PROCESS | 1679 | RSS: Main: 281640960 05:42:16 INFO - PROCESS | 1679 | 05:42:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:42:18 INFO - PROCESS | 1679 | RSS: Main: 281915392 05:42:18 INFO - PROCESS | 1679 | 05:42:20 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:42:21 INFO - PROCESS | 1679 | RSS: Main: 282177536 05:42:21 INFO - PROCESS | 1679 | 05:42:24 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:42:24 INFO - PROCESS | 1679 | RSS: Main: 282050560 05:42:24 INFO - PROCESS | 1679 | 05:42:27 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:42:28 INFO - PROCESS | 1679 | RSS: Main: 282132480 05:42:28 INFO - PROCESS | 1679 | 05:42:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 05:42:30 INFO - PROCESS | 1679 | RSS: Main: 283922432 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | __start_tp_report 05:42:30 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 05:42:30 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 05:42:30 INFO - PROCESS | 1679 | |i|pagename|runs| 05:42:30 INFO - PROCESS | 1679 | |0;ai-astar;114;111;117;115;114;129;115;117;94;174 05:42:30 INFO - PROCESS | 1679 | |1;audio-beat-detection;193;130;144;156;121;137;124;153;151;122 05:42:30 INFO - PROCESS | 1679 | |2;audio-dft;192;202;200;204;208;264;275;235;202;199 05:42:30 INFO - PROCESS | 1679 | |3;audio-fft;55;56;79;63;72;115;59;82;50;79 05:42:30 INFO - PROCESS | 1679 | |4;audio-oscillator;81;83;127;78;83;79;114;81;80;115 05:42:30 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;90;87;111;131;90;86;90;101;135;131 05:42:30 INFO - PROCESS | 1679 | |6;imaging-darkroom;117;96;96;96;95;96;96;103;96;112 05:42:30 INFO - PROCESS | 1679 | |7;imaging-desaturate;93;94;95;93;97;92;94;98;136;90 05:42:30 INFO - PROCESS | 1679 | |8;json-parse-financial;59;58;55;58;54;66;73;82;60;56 05:42:30 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;65;67;69;74;78;75;70;67;67;72 05:42:30 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;86;86;87;85;110;113;110;75;107;73 05:42:30 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;123;123;125;123;127;127;145;138;127;136 05:42:30 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;146;144;162;133;141;121;186;149;172;178 05:42:30 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;62;66;60;82;108;102;98;97;63;72 05:42:30 INFO - PROCESS | 1679 | __end_tp_report 05:42:30 INFO - PROCESS | 1679 | __start_cc_report 05:42:30 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,965 05:42:30 INFO - PROCESS | 1679 | __end_cc_report 05:42:30 INFO - PROCESS | 1679 | __startTimestamp1459341750130__endTimestamp 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | ------- Summary: start ------- 05:42:30 INFO - PROCESS | 1679 | Number of tests: 14 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:120.00 Median:117.00 stddev:20.80 (17.8%) stddev-sans-first:21.95 05:42:30 INFO - PROCESS | 1679 | Values: 114.0 111.0 117.0 115.0 114.0 129.0 115.0 117.0 94.0 174.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:147.50 stddev:21.92 (14.9%) stddev-sans-first:13.96 05:42:30 INFO - PROCESS | 1679 | Values: 193.0 130.0 144.0 156.0 121.0 137.0 124.0 153.0 151.0 122.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:218.10 Median:206.00 stddev:29.48 (14.3%) stddev-sans-first:29.72 05:42:30 INFO - PROCESS | 1679 | Values: 192.0 202.0 200.0 204.0 208.0 264.0 275.0 235.0 202.0 199.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:71.00 Median:67.50 stddev:19.19 (28.4%) stddev-sans-first:19.47 05:42:30 INFO - PROCESS | 1679 | Values: 55.0 56.0 79.0 63.0 72.0 115.0 59.0 82.0 50.0 79.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:80.50 stddev:18.71 (23.2%) stddev-sans-first:19.41 05:42:30 INFO - PROCESS | 1679 | Values: 81.0 83.0 127.0 78.0 83.0 79.0 114.0 81.0 80.0 115.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:105.20 Median:86.50 stddev:20.18 (23.3%) stddev-sans-first:20.64 05:42:30 INFO - PROCESS | 1679 | Values: 90.0 87.0 111.0 131.0 90.0 86.0 90.0 101.0 135.0 131.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:100.30 Median:96.00 stddev:7.90 (8.2%) stddev-sans-first:5.61 05:42:30 INFO - PROCESS | 1679 | Values: 117.0 96.0 96.0 96.0 95.0 96.0 96.0 103.0 96.0 112.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:98.20 Median:94.00 stddev:13.48 (14.3%) stddev-sans-first:14.17 05:42:30 INFO - PROCESS | 1679 | Values: 93.0 94.0 95.0 93.0 97.0 92.0 94.0 98.0 136.0 90.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:59.50 stddev:9.01 (15.1%) stddev-sans-first:9.49 05:42:30 INFO - PROCESS | 1679 | Values: 59.0 58.0 55.0 58.0 54.0 66.0 73.0 82.0 60.0 56.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:4.22 (5.9%) stddev-sans-first:4.00 05:42:30 INFO - PROCESS | 1679 | Values: 65.0 67.0 69.0 74.0 78.0 75.0 70.0 67.0 67.0 72.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:80.00 stddev:15.26 (19.1%) stddev-sans-first:15.96 05:42:30 INFO - PROCESS | 1679 | Values: 86.0 86.0 87.0 85.0 110.0 113.0 110.0 75.0 107.0 73.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:127.00 stddev:7.60 (6.0%) stddev-sans-first:7.70 05:42:30 INFO - PROCESS | 1679 | Values: 123.0 123.0 125.0 123.0 127.0 127.0 145.0 138.0 127.0 136.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:155.50 stddev:20.74 (13.3%) stddev-sans-first:21.83 05:42:30 INFO - PROCESS | 1679 | Values: 146.0 144.0 162.0 133.0 141.0 121.0 186.0 149.0 172.0 178.0 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.00 Median:69.00 stddev:18.70 (27.1%) stddev-sans-first:18.53 05:42:30 INFO - PROCESS | 1679 | Values: 62.0 66.0 60.0 82.0 108.0 102.0 98.0 97.0 63.0 72.0 05:42:30 INFO - PROCESS | 1679 | -------- Summary: end -------- 05:42:30 INFO - PROCESS | 1679 | 05:42:30 INFO - TEST-INFO | 1679: exit 0 05:42:30 INFO - TEST-OK | kraken | took 58893ms 05:42:30 INFO - SUITE-END | took 1171s 05:42:31 INFO - Completed test suite (00:19:31) 05:42:31 INFO - javascript benchmark 05:42:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2971.598834157389, 3196.5684632574603, 3595.352836489431, 3610.8916732498033, 3669.284489524544, 5063.7974481020765, 5360.973195134024, 5793.942060579393, 5941.613795103321, 5946.762129514815, 5774.682392468412, 5966.552508561854, 6032.0951857221435, 6064.484518815895, 6083.178770865932, 5261.579073674096, 5265.449938635731, 5340.759665815028, 5360.624756267063, 5423.593230507708, 4833.340538671046, 5364.839054828361, 5427.592930530226, 5436.619436639437, 5489.835304940858, 5290.312259406291, 5357.624966252364, 5367.302250707383, 5406.162044883049, 5407.702576358299, 5297.867553311159, 5330.600204984603, 5345.625806193568, 5373.086575282211, 5374.274472946141, 5291.523762861322, 5297.364316282033, 5335.813246536352, 5345.438728933484, 5358.732063396815, 5616.297962754656, 5697.4587414195585, 5797.855053623651, 5897.498712609433, 5911.054231322968, 6208.689565521751, 6238.87522249557, 6265.997440409558, 6266.49868010558, 6268.373162683741, 6291.465225455841, 6306.180196574416, 6306.684665766693, 6323.336049714806, 6330.430261276461, 5890.852728681817, 5965.821025369246, 6053.636781793107, 6054.96972515139, 6129.754809807558, 6317.4946004319545, 6402.679866006681, 6409.102725618417, 6414.198225221848, 6470.22357317125, 6283.654399008098, 6295.811125666238, 6310.400511951358, 6311.526635502356, 6315.431611154926, 6104.7926496150985, 6210.223722034746, 6238.438540531374, 6282.654454005074, 6300.180976473121, 6147.139400483936, 6186.381361863778, 6252.062190671345, 6260.655663938527, 6266.905996410058, 5730.914036289459, 6034.366391528914, 6035.702324000361, 6193.67181311375, 6248.812535623939, 4308.569143085729, 4828.396450443694, 4970.577500912391, 5021.14640511114, 5091.465396133427, 4485.25993211123, 4497.64018878489, 4513.954860451419, 4539.7049191802425, 4565.589096981287, 5987.221661184019, 6028.9397106029255, 6033.396660333931, 6064.36324185963, 6074.119252708421, 5292.497212764782, 6176.567640265138, 6268.811935641938, 6274.780382686676, 6316.536550745213, 4974.651774375759, 5490.764577970005, 6031.5476339273855, 6063.605865618809, 6066.090086486974, 5247.868803279948, 5401.675899446046, 5510.862228444321, 5555.472230138131, 5564.610477266552, 5641.5204707600315, 6498.805035848932, 6534.117894084333, 6540.084388185563, 6550.47596192313, 5295.0, 6309.085182648582, 6309.652969086745, 6322.083297921868, 6330.778422755181, 6241.875162496815, 6375.936240637534, 6473.902891456726, 6488.383603557654, 6498.220213574401, 6158.630482171084, 6219.595726277777, 6273.466755325849, 6290.056491526308, 6293.685315734104, 6163.660998644938, 6260.436560709558, 6288.842778930563, 6366.076918846834, 6372.458341041063, 5165.845024649267, 6042.395760424099, 6132.724027418688, 6230.252369715663, 6236.407541283571, 6109.43503133753, 6147.415995480422, 6183.598066125687, 6187.102870083722, 6189.690515474118, 6046.89489849434, 6101.7559297627595, 6113.663748493697, 6168.35232300602, 6193.81418557444, 6106.969465152823, 6107.816765497042, 6160.568760186744, 6276.152719383008, 6279.748810047729, 6097.591277512581, 6114.877702445837, 6117.522930757332, 6123.171248411065, 6153.4154255345675], "unit": "score", "name": "dojo.html", "value": 5774.154014207808}, {"lowerIsBetter": false, "replicates": [437.97076869357016, 560.3667855323483, 589.1339730596023, 590.4715279824558, 599.3497055694571, 36703.0, 37083.072923176864, 37198.90812010677, 37455.81272093639, 37472.81263593678, 38756.0, 39165.608343916625, 39200.01999949996, 39317.60682393183, 39489.0, 9349.158575728201, 9569.09093636107, 9595.568199431007, 9607.66373176939, 9622.615095396175, 9412.529373531295, 9618.470984095871, 9666.27502937279, 9676.467794271312, 9720.0, 8315.459495132827, 9646.710598682052, 9717.562709678046, 9717.562709678046, 9735.561899714494, 9648.421094734304, 9687.854682179774, 9688.0, 9704.223662107015, 9723.27075469339, 9441.622335106587, 9516.857247141299, 9572.090651388107, 9586.90413095867, 9588.041195880425, 37689.434658480146, 38080.80959595184, 38112.61887381118, 38212.42681359782, 38293.42559861604, 2753.490604238222, 3275.5250488679008, 3463.3592785334795, 3482.89551313461, 3826.5025546678753, 28544.143675689764, 28957.85521072381, 29571.0, 29574.556381654293, 29739.405211895857, 2703.9729602704115, 2803.495370833249, 2854.0866922584783, 2856.3573196030725, 2959.393324368499, 406935.0, 413895.0, 416219.0, 416631.9168404169, 417729.0, 68213.65893170502, 73301.0, 73523.0, 73564.0, 73882.0, 66430.33569664338, 78804.60597696975, 78899.21100789034, 80471.7929231062, 80540.19459805444, 17328.48014559565, 17463.650726985645, 17557.122143892753, 17557.473275801745, 17614.03122828231, 12889.742205156032, 13055.543055992996, 13114.01644876638, 13197.142185758086, 13208.801867971988, 22791.202307919142, 22836.515626484226, 22934.0, 23020.19429319999, 23243.418914527272, 8095.595220238964, 9492.477913714674, 9778.65774697882, 9823.950880245553, 9841.360311579725, 846.7925358287259, 973.4889183178747, 980.8675828763169, 1088.6679562733443, 1161.5005547614608, 26522.602160967603, 28524.42951141007, 28804.71195288062, 29257.97597084092, 29414.0, 1033.1837848099917, 1054.177741361739, 1118.1725523113, 1118.5861231344293, 1123.4438952718294, 14303.21332326732, 14522.419103235963, 14570.635734106732, 14600.561983140522, 14848.96057276002, 481590.0, 481936.0, 485657.0, 488784.0, 501903.0, 57905.71047144822, 58052.12921806176, 58137.127943080886, 58534.707326463096, 58577.828443430895, 1409.5912185466304, 1436.3751767980962, 1461.3862177885314, 1470.4559313054237, 1471.1026273972868, 22223.666645000016, 27322.36065836056, 28239.15282541527, 28884.855575721987, 29175.854120729262, 48614.27078593895, 49616.75191624019, 50109.498905010485, 50310.49689503205, 50433.74783126061, 464604.0, 467030.0, 467690.0, 468426.0, 471582.0, 33729.988100357026, 33930.66069339275, 34543.0, 43748.56251437445, 44852.77573612111, 42026.94932626709, 42270.36594451024, 42602.57397425986, 42877.356839648055, 43305.56694433015, 27829.0, 28041.71958280391, 28058.158255252376, 28320.0, 28483.0, 36206.91379258627, 37698.62301377061, 38570.228595427376, 39431.408528872664, 39470.40794388144, 35696.0, 36425.0, 36934.63065369419, 37477.43783843299, 37601.62398375981, 31267.0, 31958.041258762274, 32557.34885302328, 33186.83406582951, 33329.166770830925, 19851.702224466357, 21494.140234391074, 24757.0, 25269.87365063163, 25349.619755704047], "unit": "score", "name": "ext.html", "value": 19780.29702209118}, {"lowerIsBetter": false, "replicates": [354.10764872521247, 361.4650317530055, 367.37729548415433, 368.9501917241172, 370.5793923896377, 17238.0519071451, 19441.805581944194, 19596.412107636777, 20393.980300984927, 20658.89670551647, 20536.691949620767, 20895.373138805822, 21052.368428947117, 21085.894570527125, 21278.0, 5722.914156287659, 5863.179154918314, 5920.378360272174, 5932.228810254661, 5951.6429014259065, 3977.2244412339605, 5295.708736019517, 6179.62922224668, 6442.581232219914, 6457.3865482779065, 6328.841778955517, 6375.3943375379495, 6389.520785941073, 6401.16784817973, 6401.967990160043, 6016.669083200422, 6275.592086514362, 6276.246850377984, 6279.623222606635, 6283.968580157116, 5157.0, 5394.703291318976, 5442.809501667422, 5444.754986025639, 5452.727363631802, 22723.318300451014, 23685.0, 24430.877845610838, 24514.509709805883, 24899.875500622562, 1911.9330823421114, 2043.795620437959, 2061.9690704639443, 2262.6832243485924, 2453.5338285725657, 9512.857307140399, 9595.568199431042, 9743.123118919331, 9761.0, 9788.706338809847, 1468.3759402254107, 1733.1507561295, 1757.4464043826154, 1831.5878927241397, 1857.8327950484386, 88005.07954284146, 94369.0, 102856.0, 106372.46813765881, 107043.92956070496, 9232.307576931622, 10980.505877235544, 11042.668719938414, 11078.944605276922, 11196.720081997852, 12985.480580776852, 13433.932830335785, 13593.116447430886, 13642.658933526543, 13660.453581856813, 8460.153984601491, 8718.302535797122, 8744.562771861381, 8769.824603507894, 8809.515476648847, 8929.776755581162, 8942.597583108776, 8946.507942063248, 8956.955215223883, 8964.551772411483, 4188.350805625133, 4382.715123516961, 4412.161689279027, 4468.776561171929, 4482.372467854503, 1775.8934463932205, 1830.9542261443305, 1851.5000949743762, 1879.821416965386, 1921.269917431367, 899.1098812175899, 904.737626088427, 951.3911096897991, 964.9565769540387, 1008.9394636321697, 13817.240051797047, 17722.0, 18959.672822902263, 20102.798972010387, 20284.898575507028, 914.4421902639384, 927.3462209142539, 967.7532229281488, 1006.2101250518308, 1021.7139201023725, 10701.357918524913, 10821.458927053773, 10824.0, 10861.728456788644, 10917.39954302505, 601886.9716954249, 604077.0, 606580.0, 610217.0, 639545.0, 110531.44734276277, 115153.0, 116060.41969790097, 118854.0, 120522.0, 999.5252255178877, 1000.9699709008742, 1014.5688082564881, 1018.9184865210765, 1035.4460363705532, 17643.55891102733, 17723.46829595114, 17842.01868897171, 17892.46322610324, 17932.91033544876, 31886.681133188373, 32429.837850810596, 48054.55836324916, 50083.99832003412, 50317.74841125771, 69885.95171072539, 71252.0, 72120.9181862262, 72239.63880180566, 73975.63012184904, 7391.2978267064545, 7486.401087912845, 7520.172780993977, 7528.774136775905, 7795.064592248967, 9826.705198844045, 11922.105842062054, 11967.222130561486, 12065.09511786602, 12225.69435764113, 10311.690649280534, 10501.737456563647, 10537.157027437634, 10589.894101058891, 10629.0, 10243.129334006693, 10260.281780275309, 10315.329503582243, 10496.16030717556, 10643.680689579325, 8793.780155496164, 9149.451032938045, 10554.525046373084, 10616.84074738895, 10901.945490272497, 7420.146683131293, 7446.962765186356, 7519.511231769918, 7706.036745406825, 7767.883481747665, 8017.478863873829, 8284.751457456287, 10486.947565262124, 10503.842442363524, 10671.679849604525], "unit": "score", "name": "jquery.html", "value": 9152.307443481672}, {"lowerIsBetter": false, "replicates": [1438.510906291861, 1634.1584084196636, 1801.8288262615047, 1880.7178923161523, 1896.4500294914485, 7085.397741192005, 7321.926780732191, 7956.840863182733, 8885.200331970122, 8974.102589741022, 7309.780706578797, 8740.606672699729, 8803.911960880389, 8825.117488251171, 8830.60262288197, 2095.7904209579033, 2502.674652295199, 2529.29179829648, 2534.4424226670194, 2535.3408113890337, 2033.7356143701297, 2432.52565749678, 2502.5745623244, 2513.3842208658903, 2516.7986561075163, 2490.489449662815, 2495.5757521221344, 2501.9749802501924, 2520.243926821955, 2523.8611876346795, 2445.425325048612, 2452.681151450309, 2452.730199678034, 2498.6626805381406, 2523.0, 2462.1628646260356, 2486.465409936872, 2494.0, 2495.238952119603, 2534.0750626021554, 8873.600687969058, 8919.79582756326, 8961.507117108556, 8968.820623587557, 8984.640614375417, 5516.200150978126, 5553.278073850373, 5603.775848966036, 5606.467385598362, 5655.953648575027, 3634.800085995269, 3711.109333759905, 3776.6412190841825, 3783.129880127586, 3788.753731007503, 1025.5692609104194, 1036.1865935240876, 1036.7719101797593, 1039.1790485516433, 1040.3653771199563, 12237.938810305892, 12314.938425307817, 12351.752964940652, 12361.196522226026, 12379.762023797548, 4924.0, 4967.230079337708, 4970.701757894538, 5011.599072074226, 5036.622253331015, 10081.243906707026, 10111.544980475895, 10143.28996970205, 10385.480725963671, 10387.584496620202, 5448.128299472065, 5566.944330556643, 5583.413741557078, 5614.326280846324, 5638.746256418471, 4506.887327816765, 4862.5380588844, 4935.333729946411, 4950.777215025332, 5068.315777370081, 3882.2235552889533, 3916.3146449371247, 3972.483577134954, 3978.0452691353867, 4000.739951903117, 1321.4053675845907, 1325.4101924643635, 1326.9800952985713, 1333.999500374719, 1340.1088276296348, 1091.5851976248975, 1123.5674265407877, 1311.1477539599337, 1399.6081097292774, 1405.7891316302637, 7946.006749156356, 8086.595670216466, 8095.0, 8110.716124935599, 8119.228673276029, 451.4988362917159, 528.9444608316148, 537.7284471342025, 1194.9283043017447, 1276.6489215465635, 6316.557840951181, 6344.175257216532, 6398.904016439664, 6416.711247993851, 6422.068800023971, 10623.0, 10685.038346548848, 10721.249512534048, 10991.835122473169, 10999.450027498753, 10424.061834434937, 10862.565497380174, 10912.727181820359, 10943.23397362193, 11010.119190464744, 8340.41617086798, 8343.290820280345, 8387.203215694499, 8439.0, 8490.915090849136, 7903.328217101611, 7904.881426778488, 7937.484063535851, 7974.601269936596, 8071.434999549975, 9826.263030272616, 9861.865885423269, 9873.703788886345, 9964.352317099365, 9980.0, 9939.453330066915, 10040.640449494509, 10352.430616315874, 10360.948195258976, 10426.68719938403, 6522.706478208587, 6935.410490108397, 6973.79078627642, 7137.0, 7172.246914073947, 8348.33213342919, 8351.997760268563, 8395.370347223861, 8433.704820331504, 8457.36569757283, 7196.748113815991, 7353.0, 7486.625668716433, 7575.090989081125, 7605.163432022362, 7118.85762284741, 7197.244289349753, 7207.13514378278, 7221.8084016136745, 7228.9277107230355, 7705.730299439493, 7786.377089832687, 7884.0, 7889.684412623431, 7944.093417579855, 7061.364477197077, 7064.576125432285, 7136.821579460555, 7138.46461515378, 7140.750073747394, 7197.748078817216, 7270.200277969313, 7282.380997615051, 7328.853422931618, 7370.889436658562], "unit": "score", "name": "mootools.html", "value": 4944.269112858571}, {"lowerIsBetter": false, "replicates": [329.70656116056716, 330.2338574507143, 335.9798412095276, 338.2069048082247, 343.66492669647096, 5613.7473813678325, 7008.719651213958, 7060.717571297142, 7062.5056246062795, 7069.929300706991, 5545.500904918556, 6928.445724342053, 6971.337722916315, 6973.686184121714, 7019.157701075866, 4856.417229932413, 4956.355673762406, 5065.873353166164, 5089.694618322894, 5134.845954621367, 5062.987402519492, 5088.643794934356, 5111.565516931066, 5114.872128196787, 5126.128558145106, 5049.722265275408, 5050.646454748169, 5051.469595692454, 5060.316857224283, 5067.569256613174, 5050.696958182521, 5057.5701065409485, 5059.418166910816, 5068.0, 5087.745612719368, 4340.761258130801, 4351.064521127941, 4351.216780979423, 4364.0, 4389.692721509464, 6487.22153341602, 6682.164729408824, 6711.228208755958, 6730.9903514472735, 6762.492813038993, 5907.616004959664, 5957.076653118774, 5997.250343707036, 6004.949133901549, 6009.278886533644, 7448.0, 7455.291747283999, 7462.141853686841, 7468.813279667997, 7492.36314913233, 4067.1865626874446, 4892.094962431962, 4900.6569540132205, 4908.410990681141, 4922.827701030446, 7126.786196414116, 7883.211678832128, 7888.881666774945, 7895.210478952059, 7903.051633803922, 4892.119418504632, 4949.158643030693, 4967.776450059756, 4980.0, 4989.226669866177, 5061.316722242524, 5062.265971434122, 5070.847874563769, 5081.0854046272025, 5093.777493401557, 4858.222684370484, 5976.073708575178, 6018.247719035121, 6044.576879618472, 6046.939530604725, 7540.359069479046, 7547.28300811422, 7560.886586701204, 7573.810654733566, 7575.053118360205, 1677.8154403015658, 1734.072271334855, 1737.843594076514, 1760.700680884227, 1777.6355847051323, 1011.8482227665909, 1110.4780753046055, 1135.5571327182406, 1138.385271953136, 1145.7823013627385, 6817.147856517935, 6881.759138430231, 6903.344182302673, 6925.896111558331, 6935.653217339112, 7694.153643099255, 7695.730649427243, 7751.302382785464, 7774.105977812511, 7793.844123117506, 6924.4114250289285, 6933.064036355027, 6954.617496037767, 6959.234484206733, 6968.547044442095, 3346.5314855919705, 3815.6184381562175, 4056.14820887611, 4106.650934670586, 4112.897177570585, 7981.800454988672, 8105.1084380718075, 8109.432339736162, 8118.35053195743, 8127.674893004214, 8159.67361305553, 8163.95918020418, 8174.468659537111, 8186.590670466453, 8198.38512111594, 6736.461083113241, 8098.068722096917, 8223.05434874997, 8223.259906608433, 8258.628361723737, 7647.885281720667, 7800.141984381827, 7803.258690424627, 7897.723579674684, 7921.564313962557, 6759.86480270382, 7245.616402076878, 7742.0, 7754.030746156731, 7782.416318776001, 8167.0, 8175.7138500152205, 8180.46826956246, 8183.181681831769, 8195.508269503849, 4147.2534943709215, 5041.495850414929, 5043.420006699276, 5050.494950505067, 5065.265536497113, 6328.272248691459, 7196.2009497625595, 7528.774136775905, 7814.4529882907655, 7850.960745196237, 6439.227292724903, 6831.316868313129, 6850.212225593921, 7510.586917719359, 7512.060992375953, 7518.518888766804, 7520.736774212876, 7535.208803075599, 7543.698252069856, 7558.0, 7106.289371063059, 7375.889361659472, 7391.556506609621, 7403.851922961619, 7408.518446300973, 6838.418734407631, 7533.773986780406, 7561.962190189014, 7563.0, 7569.6593653284635, 6500.25247096571, 6938.230751158422, 7281.963590182015, 7293.708251669874, 7384.741534046282], "unit": "score", "name": "prototype.html", "value": 5419.1322603609015}, {"lowerIsBetter": false, "replicates": [672.3075232510514, 720.7369310201778, 749.9362554182894, 753.604357712201, 759.6493315879245, 14448.349824257908, 14632.4878629248, 14739.263036848168, 14749.557513274605, 14765.114093154418, 13687.863121368784, 13729.931350343259, 13754.243516606582, 13773.51792687256, 13798.655033624165, 728.9854202915939, 901.2384535067857, 913.9086091390874, 916.038159932072, 940.8165407745493, 891.6210610490548, 922.0134456131908, 929.2101713543501, 930.1210356213381, 930.9394889332171, 924.8566472196786, 951.4243882451121, 963.5134257200104, 965.2374624046995, 967.4243824924159, 918.4948278446861, 941.9152276295132, 947.2422062350092, 955.2262667239559, 961.942283462991, 696.4985210648325, 697.1425147069133, 708.4155571653355, 709.4359983812881, 728.8250819803262, 14480.986330956837, 14484.855151448455, 14524.055936364208, 14663.63340916475, 14780.187089710062, 12438.937805311007, 12441.440135193938, 12580.43388047531, 12768.361581920866, 12873.67815804603, 9841.311108222428, 9947.0, 10015.59937602495, 10070.597176112946, 10299.588016479333, 3479.599846017715, 3511.841967111486, 3513.332466831294, 3514.6485351464903, 3522.5772907251294, 83818.0, 84893.3021339576, 86755.13244867534, 86876.0, 87098.25803483959, 8467.36494762883, 9469.063545150508, 9504.192143667728, 9542.188913942255, 9580.329376943686, 20550.58898822015, 20801.479963000744, 20939.267125650527, 20952.0, 20957.68563471549, 6396.648184349905, 6412.134361861183, 6506.512011599149, 6506.739730410731, 6516.837079073061, 4028.5568587455355, 4058.492688413948, 4165.291900376943, 4180.874573762792, 4198.517170525429, 3580.820958952042, 3589.353916295092, 3613.9096522587147, 3614.945775813312, 3627.764195327295, 656.3108735827362, 661.7154623511937, 662.2053535757111, 670.7149461478851, 671.362205904383, 485.1727804094011, 535.7669413804929, 563.7265926025874, 585.1982783586514, 612.8437248501692, 8018.238267364591, 8216.835663286702, 8293.792655183548, 8296.8340633187, 8406.118948714658, 480.1549273278984, 536.2546060975247, 537.5941164420838, 591.4263164730205, 606.0696830365368, 3202.0553936588763, 3235.5793746813233, 3469.5663042119736, 3806.218019689372, 3828.1960788234783, 92185.0, 92674.60988085184, 94086.0, 94669.0, 95361.0463895366, 78170.6091469539, 78171.0, 78600.6069969658, 79543.80684289741, 80863.0, 67842.98235526372, 69005.0, 70446.64776676084, 71226.6438667793, 71877.0, 7725.072991241087, 7929.405294603043, 7939.761807145795, 8002.7199048033035, 8229.300509456763, 51129.0, 52087.21869172041, 52225.21662174995, 52268.73865630647, 52426.42720718384, 65558.0, 67496.32503674901, 68448.63102738016, 72091.90191429107, 72139.27860721535, 9868.407895526292, 9893.208543316374, 9980.850287245552, 10216.131628811634, 10400.791984160123, 9324.0, 10817.675469735921, 10852.131829453467, 10886.23796334249, 10994.945025274823, 8798.472091674264, 10355.119814815524, 10355.482225888525, 10531.631392901212, 10839.620613278497, 10141.898581014095, 10370.948145259526, 10482.780482730988, 10775.976282253174, 11316.15128865322, 8533.786655333666, 9095.317851161057, 9745.707628771148, 9792.461414622265, 10125.797484050425, 8684.261837743863, 8763.693270735494, 9750.658726944523, 9875.259355548218, 9905.257105716955, 9487.715368538955, 9673.274504412339, 9732.854007190039, 9735.805283894424, 9760.072793084646], "unit": "score", "name": "yui.html", "value": 6744.489631051588}], "name": "dromaeo_css", "value": 7574.912435193858}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 117.0, 115.0, 114.0, 129.0, 115.0, 117.0, 94.0, 174.0], "unit": "score", "name": "ai-astar", "value": 120.0}, {"lowerIsBetter": true, "replicates": [193.0, 130.0, 144.0, 156.0, 121.0, 137.0, 124.0, 153.0, 151.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [192.0, 202.0, 200.0, 204.0, 208.0, 264.0, 275.0, 235.0, 202.0, 199.0], "unit": "score", "name": "audio-dft", "value": 218.1}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 79.0, 63.0, 72.0, 115.0, 59.0, 82.0, 50.0, 79.0], "unit": "score", "name": "audio-fft", "value": 71.0}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 127.0, 78.0, 83.0, 79.0, 114.0, 81.0, 80.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 92.1}, {"lowerIsBetter": true, "replicates": [90.0, 87.0, 111.0, 131.0, 90.0, 86.0, 90.0, 101.0, 135.0, 131.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 105.2}, {"lowerIsBetter": true, "replicates": [117.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 103.0, 96.0, 112.0], "unit": "score", "name": "imaging-darkroom", "value": 100.3}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 95.0, 93.0, 97.0, 92.0, 94.0, 98.0, 136.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 98.2}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 55.0, 58.0, 54.0, 66.0, 73.0, 82.0, 60.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 62.1}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 69.0, 74.0, 78.0, 75.0, 70.0, 67.0, 67.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.4}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 87.0, 85.0, 110.0, 113.0, 110.0, 75.0, 107.0, 73.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.2}, {"lowerIsBetter": true, "replicates": [123.0, 123.0, 125.0, 123.0, 127.0, 127.0, 145.0, 138.0, 127.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.4}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 162.0, 133.0, 141.0, 121.0, 186.0, 149.0, 172.0, 178.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.2}, {"lowerIsBetter": true, "replicates": [62.0, 66.0, 60.0, 82.0, 108.0, 102.0, 98.0, 97.0, 63.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 81.0}], "name": "kraken", "value": 1537.3000000000004}]} 05:42:31 INFO - Return code: 0 05:42:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:42:31 ERROR - # TBPL SUCCESS # 05:42:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:42:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:42:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:42:31 INFO - 2016-03-30 05:42:31.425 screenresolution[1684:10203] starting screenresolution argv=screenresolution get 05:42:31 INFO - 2016-03-30 05:42:31.427 screenresolution[1684:10203] Display 0: 1600x1200x32@60 05:42:31 INFO - 2016-03-30 05:42:31.433 screenresolution[1685:10206] starting screenresolution argv=screenresolution list 05:42:31 INFO - Available Modes on Display 0 05:42:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:42:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:42:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:42:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:42:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:42:31 INFO - Intel Iris: 05:42:31 INFO - Chipset Model: Intel Iris 05:42:31 INFO - Type: GPU 05:42:31 INFO - Bus: Built-In 05:42:31 INFO - VRAM (Dynamic, Max): 1536 MB 05:42:31 INFO - Vendor: Intel (0x8086) 05:42:31 INFO - Device ID: 0x0a2e 05:42:31 INFO - Revision ID: 0x0009 05:42:31 INFO - Displays: 05:42:31 INFO - Display: 05:42:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:42:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:42:31 INFO - Display Serial Number: 1600x1200 60 05:42:31 INFO - Main Display: Yes 05:42:31 INFO - Mirror: Off 05:42:31 INFO - Online: Yes 05:42:31 INFO - Rotation: Supported 05:42:31 INFO - Return code: 0 05:42:31 INFO - Running post-action listener: _resource_record_post_action 05:42:31 INFO - Running post-run listener: _resource_record_post_run 05:42:32 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 39949824; Write bytes: 708178432; Read time: 434; Write time: 2230 05:42:32 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402661888; Write bytes: 396449792; Read time: 30101; Write time: 749 05:42:32 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 34353152; Write bytes: 302782976; Read time: 364; Write time: 1448 05:42:32 INFO - Running post-run listener: _upload_blobber_files 05:42:32 INFO - Blob upload gear active. 05:42:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:42: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:42: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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:42: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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:42:33 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:42:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:42:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:34 INFO - (blobuploader) - INFO - Done attempting. 05:42:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:42:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:42:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:35 INFO - (blobuploader) - INFO - Done attempting. 05:42:35 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:35 INFO - Return code: 0 05:42:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:42:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ebbb190230adbc6629b77583fc8d158c16a4baad40f976c4460fae116dfdb30d73a6fd0eb9317a15c45fa1db71e35443c8d0662ca430098ac6371820329e03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14000e75349ad734b8fb20792828a11e45ffedbc3a182e115050882c41eead31c60af1d5cee599d072e77ea1dc9091f0e755884524696c4fae519b32232f69e3"} 05:42:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:42:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:42:35 INFO - Contents: 05:42:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ebbb190230adbc6629b77583fc8d158c16a4baad40f976c4460fae116dfdb30d73a6fd0eb9317a15c45fa1db71e35443c8d0662ca430098ac6371820329e03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14000e75349ad734b8fb20792828a11e45ffedbc3a182e115050882c41eead31c60af1d5cee599d072e77ea1dc9091f0e755884524696c4fae519b32232f69e3"} 05:42:35 INFO - Running post-run listener: copy_logs_to_upload_dir 05:42:35 INFO - Copying logs to upload dir... 05:42:35 INFO - mkdir: /builds/slave/test/build/upload/logs 05:42:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.715889 ========= master_lag: 3.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-30 05:42:39.171667) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 05:42:39.180486) ========= 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.T6G6lLsCf1/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.PrL5n2emwq/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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/Firefox/sha512/73ebbb190230adbc6629b77583fc8d158c16a4baad40f976c4460fae116dfdb30d73a6fd0eb9317a15c45fa1db71e35443c8d0662ca430098ac6371820329e03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14000e75349ad734b8fb20792828a11e45ffedbc3a182e115050882c41eead31c60af1d5cee599d072e77ea1dc9091f0e755884524696c4fae519b32232f69e3"} build_url:https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011086 build_url: 'https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ebbb190230adbc6629b77583fc8d158c16a4baad40f976c4460fae116dfdb30d73a6fd0eb9317a15c45fa1db71e35443c8d0662ca430098ac6371820329e03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14000e75349ad734b8fb20792828a11e45ffedbc3a182e115050882c41eead31c60af1d5cee599d072e77ea1dc9091f0e755884524696c4fae519b32232f69e3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 05:42:39.225271) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:42:39.225637) ========= 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.T6G6lLsCf1/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.PrL5n2emwq/Listeners TMPDIR=/var/folders/np/gxqtlmy15cvfysz9zj9x958r00000w/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.005017 ========= master_lag: 0.19 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:42:39.419986) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 05:42:39.420339) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 05:42:39.423164) ========= ========= Total master_lag: 4.32 =========