builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0072 starttime: 1458317522.47 results: success (0) buildid: 20160318073312 builduid: fe7dfe6ef4a74bf0b93c1aceadce754d revision: 3d37c7e5b8dd28a4a017e2296e824619f9379b88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.466989) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.467496) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.467843) ========= 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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005477 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.493169) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.493489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.511837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.512146) ========= 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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005813 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.560417) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.560762) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.561296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.561687) ========= 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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-18 09:12:02-- 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% 193M=0s 2016-03-18 09:12:02 (193 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114552 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.696128) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.696908) ========= 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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.027094 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:02.750823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 09:12:02.751223) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3d37c7e5b8dd28a4a017e2296e824619f9379b88 --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 3d37c7e5b8dd28a4a017e2296e824619f9379b88 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EAC4iOh9T7/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.gYgnY2HSdv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-18 09:12:02,827 truncating revision to first 12 chars 2016-03-18 09:12:02,827 Setting DEBUG logging. 2016-03-18 09:12:02,827 attempt 1/10 2016-03-18 09:12:02,827 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3d37c7e5b8dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 09:12:03,834 unpacking tar archive at: mozilla-central-3d37c7e5b8dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.258267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 09:12:04.027348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:04.027767) ========= echo 3d37c7e5b8dd28a4a017e2296e824619f9379b88 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3d37c7e5b8dd28a4a017e2296e824619f9379b88'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EAC4iOh9T7/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.gYgnY2HSdv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 3d37c7e5b8dd28a4a017e2296e824619f9379b88 program finished with exit code 0 elapsedTime=0.005339 script_repo_revision: '3d37c7e5b8dd28a4a017e2296e824619f9379b88' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:04.076538) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:04.076928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 09:12:04.091690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-18 09:12:04.092000) ========= /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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09:12:04 INFO - MultiFileLogger online at 20160318 09:12:04 in /builds/slave/test 09:12:04 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 09:12:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:12:04 INFO - {'append_to_log': False, 09:12:04 INFO - 'base_work_dir': '/builds/slave/test', 09:12:04 INFO - 'blob_upload_branch': 'Firefox', 09:12:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:12:04 INFO - 'branch': 'Firefox', 09:12:04 INFO - 'buildbot_json_path': 'buildprops.json', 09:12:04 INFO - 'config_files': ('talos/mac_config.py',), 09:12:04 INFO - 'default_actions': ('clobber', 09:12:04 INFO - 'read-buildbot-config', 09:12:04 INFO - 'download-and-extract', 09:12:04 INFO - 'populate-webroot', 09:12:04 INFO - 'create-virtualenv', 09:12:04 INFO - 'install', 09:12:04 INFO - 'run-tests'), 09:12:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:12:04 INFO - 'download_minidump_stackwalk': True, 09:12:04 INFO - 'download_symbols': 'ondemand', 09:12:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:12:04 INFO - 'tooltool.py': '/tools/tooltool.py', 09:12:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:12:04 INFO - '/tools/misc-python/virtualenv.py')}, 09:12:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:12:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:12:04 INFO - 'installer_path': 'installer.exe', 09:12:04 INFO - 'log_level': 'info', 09:12:04 INFO - 'log_name': 'talos', 09:12:04 INFO - 'log_to_console': True, 09:12:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:12:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:12:04 INFO - 'opt_config_files': (), 09:12:04 INFO - 'pip_index': False, 09:12:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:12:04 INFO - 'cmd': ('bash', 09:12:04 INFO - '-c', 09:12:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:12:04 INFO - 'enabled': True, 09:12:04 INFO - 'halt_on_failure': False, 09:12:04 INFO - 'name': 'check_screen_resolution'},), 09:12:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:12:04 INFO - 'cmd': ('bash', 09:12:04 INFO - '-c', 09:12:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:12:04 INFO - 'enabled': True, 09:12:04 INFO - 'halt_on_failure': False, 09:12:04 INFO - 'name': 'check_screen_resolution'},), 09:12:04 INFO - 'run_cmd_checks_enabled': True, 09:12:04 INFO - 'sps_profile': False, 09:12:04 INFO - 'sps_profile_interval': 0, 09:12:04 INFO - 'suite': 'dromaeojs-e10s', 09:12:04 INFO - 'system_bits': '32', 09:12:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:12:04 INFO - 'title': 't-yosemite-r7-0072', 09:12:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:12:04 INFO - 'use_talos_json': True, 09:12:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:12:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:12:04 INFO - 'work_dir': 'build'} 09:12:04 INFO - ##### 09:12:04 INFO - ##### Running clobber step. 09:12:04 INFO - ##### 09:12:04 INFO - Running pre-action listener: _resource_record_pre_action 09:12:04 INFO - Running main action method: clobber 09:12:04 INFO - rmtree: /builds/slave/test/build 09:12:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:12:05 INFO - Running post-action listener: _resource_record_post_action 09:12:05 INFO - ##### 09:12:05 INFO - ##### Running read-buildbot-config step. 09:12:05 INFO - ##### 09:12:05 INFO - Running pre-action listener: _resource_record_pre_action 09:12:05 INFO - Running main action method: read_buildbot_config 09:12:05 INFO - Using buildbot properties: 09:12:05 INFO - { 09:12:05 INFO - "project": "", 09:12:05 INFO - "product": "firefox", 09:12:05 INFO - "script_repo_revision": "production", 09:12:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:12:05 INFO - "repository": "", 09:12:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:12:05 INFO - "buildid": "20160318073312", 09:12:05 INFO - "pgo_build": "False", 09:12:05 INFO - "basedir": "/builds/slave/test", 09:12:05 INFO - "buildnumber": 207, 09:12:05 INFO - "slavename": "t-yosemite-r7-0072", 09:12:05 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:12:05 INFO - "platform": "yosemite_r7", 09:12:05 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:12:05 INFO - "branch": "mozilla-central", 09:12:05 INFO - "repo_path": "mozilla-central", 09:12:05 INFO - "revision": "3d37c7e5b8dd28a4a017e2296e824619f9379b88", 09:12:05 INFO - "stage_platform": "macosx64", 09:12:05 INFO - "builduid": "fe7dfe6ef4a74bf0b93c1aceadce754d", 09:12:05 INFO - "slavebuilddir": "test" 09:12:05 INFO - } 09:12:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:12:05 INFO - Running post-action listener: _resource_record_post_action 09:12:05 INFO - ##### 09:12:05 INFO - ##### Running download-and-extract step. 09:12:05 INFO - ##### 09:12:05 INFO - Running pre-action listener: _resource_record_pre_action 09:12:05 INFO - Running main action method: download_and_extract 09:12:05 INFO - mkdir: /builds/slave/test/build/tests 09:12: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')]} 09:12:05 INFO - https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:12:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:12:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:12:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/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 09:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/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 09:12:06 INFO - Downloaded 1199 bytes. 09:12:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:12:06 INFO - Using the following test package requirements: 09:12:06 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:12:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:06 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:12:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:06 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:12:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:06 INFO - u'jsshell-mac.zip'], 09:12:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:06 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:12:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:12:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:06 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:12:06 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:06 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:12:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:06 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:12:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:12:06 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:12:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:12:06 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')]} 09:12:06 INFO - https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:12:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:12:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:12:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/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 09:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/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 09:12:08 INFO - Downloaded 17870604 bytes. 09:12:08 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'] 09:12:08 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 09:12:11 INFO - Return code: 0 09:12:11 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 09:12:11 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')]} 09:12:11 INFO - https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:12:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:12:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:12:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/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 09:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/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 09:12:13 INFO - Downloaded 17870604 bytes. 09:12:13 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'] 09:12:13 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 09:12:17 INFO - Return code: 0 09:12:17 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')]} 09:12:17 INFO - https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:12:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:12:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:12:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/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 09:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/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 09:12:19 INFO - Downloaded 10846565 bytes. 09:12:19 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'] 09:12:19 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 09:12:19 INFO - Return code: 0 09:12: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')]} 09:12:19 INFO - https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:12:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:12:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:12:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMbZDkD9Rr--w80yB63lLg/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 09:12:26 INFO - Downloaded 111180773 bytes. 09:12:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:12:26 INFO - mkdir: /builds/slave/test/properties 09:12:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:12:26 INFO - Writing to file /builds/slave/test/properties/build_url 09:12:26 INFO - Contents: 09:12:26 INFO - build_url:https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:12:27 INFO - Running post-action listener: _resource_record_post_action 09:12:27 INFO - Running post-action listener: set_extra_try_arguments 09:12:27 INFO - ##### 09:12:27 INFO - ##### Running populate-webroot step. 09:12:27 INFO - ##### 09:12:27 INFO - Running pre-action listener: _resource_record_pre_action 09:12:27 INFO - Running main action method: populate_webroot 09:12:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:12:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:12:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:12:27 INFO - '--tppagecycles', 09:12:27 INFO - '7'], 09:12:27 INFO - 'tests': ['tsvgm']}}, 09:12:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:12:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:12:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:12:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:12:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:12:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:12:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:27 INFO - 'talos_options': ['--e10s'], 09:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:27 INFO - 'tests': ['damp', 'tps']}, 09:12:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:27 INFO - 'talos_options': ['--e10s'], 09:12:27 INFO - 'tests': ['damp', 'tps']}, 09:12:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:12:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:12:27 INFO - 'other': {'tests': ['a11yr', 09:12:27 INFO - 'ts_paint', 09:12:27 INFO - 'tpaint', 09:12:27 INFO - 'sessionrestore', 09:12:27 INFO - 'sessionrestore_no_auto_restore', 09:12:27 INFO - 'tabpaint']}, 09:12:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:12:27 INFO - 'tests': ['a11yr', 09:12:27 INFO - 'ts_paint', 09:12:27 INFO - 'tpaint', 09:12:27 INFO - 'sessionrestore', 09:12:27 INFO - 'sessionrestore_no_auto_restore', 09:12:27 INFO - 'tabpaint']}, 09:12:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:12:27 INFO - 'tests': ['a11yr', 09:12:27 INFO - 'ts_paint', 09:12:27 INFO - 'tpaint', 09:12:27 INFO - 'sessionrestore', 09:12:27 INFO - 'sessionrestore_no_auto_restore', 09:12:27 INFO - 'tabpaint']}, 09:12:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:12:27 INFO - 'tests': ['a11yr', 09:12:27 INFO - 'ts_paint', 09:12:27 INFO - 'tpaint', 09:12:27 INFO - 'sessionrestore', 09:12:27 INFO - 'sessionrestore_no_auto_restore', 09:12:27 INFO - 'tabpaint']}, 09:12:27 INFO - 'other_l64': {'tests': ['a11yr', 09:12:27 INFO - 'ts_paint', 09:12:27 INFO - 'tpaint', 09:12:27 INFO - 'sessionrestore', 09:12:27 INFO - 'sessionrestore_no_auto_restore', 09:12:27 INFO - 'tabpaint']}, 09:12:27 INFO - 'other_nol64': {'tests': ['a11yr', 09:12:27 INFO - 'ts_paint', 09:12:27 INFO - 'tpaint', 09:12:27 INFO - 'sessionrestore', 09:12:27 INFO - 'sessionrestore_no_auto_restore', 09:12:27 INFO - 'tabpaint']}, 09:12:27 INFO - 'svgr': {'tests': ['tsvgx', 09:12:27 INFO - 'tsvgr_opacity', 09:12:27 INFO - 'tart', 09:12:27 INFO - 'tscrollx', 09:12:27 INFO - 'cart']}, 09:12:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:12:27 INFO - 'tests': ['tsvgx', 09:12:27 INFO - 'tsvgr_opacity', 09:12:27 INFO - 'tart', 09:12:27 INFO - 'tscrollx', 09:12:27 INFO - 'cart']}, 09:12:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:27 INFO - 'tests': ['tp5o']}, 09:12:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:27 INFO - 'talos_options': ['--e10s'], 09:12:27 INFO - 'tests': ['tp5o']}, 09:12:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:27 INFO - 'talos_options': ['--xperf_path', 09:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:27 INFO - 'tests': ['tp5n']}, 09:12:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:27 INFO - 'talos_options': ['--e10s', 09:12:27 INFO - '--xperf_path', 09:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:27 INFO - 'tests': ['tp5n']}}, 09:12:27 INFO - 'talos.zip': {'path': '', 09:12:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:12:27 INFO - Running post-action listener: _resource_record_post_action 09:12:27 INFO - ##### 09:12:27 INFO - ##### Running create-virtualenv step. 09:12:27 INFO - ##### 09:12:27 INFO - Running pre-action listener: _resource_record_pre_action 09:12:27 INFO - Running main action method: create_virtualenv 09:12:27 INFO - Creating virtualenv /builds/slave/test/build/venv 09:12:27 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 09:12:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:12:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:12:27 INFO - Using real prefix '/tools/python27' 09:12:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:12:28 INFO - Installing distribute.............................................................................................................................................................................................done. 09:12:31 INFO - Installing pip.................done. 09:12:31 INFO - Return code: 0 09:12:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:12:31 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')]} 09:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:31 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')]} 09:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:31 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 0x10d384a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d394420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd8c91390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d223e00>, '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 0x10d08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21eb20>, '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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09:12:31 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 09:12:31 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 09:12:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EAC4iOh9T7/Render', 09:12:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:31 INFO - 'HOME': '/Users/cltbld', 09:12:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:31 INFO - 'LOGNAME': 'cltbld', 09:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:31 INFO - 'MOZ_NO_REMOTE': '1', 09:12:31 INFO - 'NO_EM_RESTART': '1', 09:12:31 INFO - 'PAGER': '/bin/cat', 09:12:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:31 INFO - 'PWD': '/builds/slave/test', 09:12:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:31 INFO - 'SHELL': '/bin/bash', 09:12:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYgnY2HSdv/Listeners', 09:12:31 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 09:12:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:31 INFO - 'USER': 'cltbld', 09:12:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:31 INFO - 'XPC_FLAGS': '0x0', 09:12:31 INFO - 'XPC_SERVICE_NAME': '0', 09:12:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:31 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 09:12:31 INFO - Cleaning up... 09:12:31 INFO - Return code: 0 09:12:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:12:31 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')]} 09:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:31 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')]} 09:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:31 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 0x10d384a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d394420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd8c91390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d223e00>, '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 0x10d08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21eb20>, '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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09:12:31 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 09:12:31 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 09:12:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EAC4iOh9T7/Render', 09:12:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:31 INFO - 'HOME': '/Users/cltbld', 09:12:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:31 INFO - 'LOGNAME': 'cltbld', 09:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:31 INFO - 'MOZ_NO_REMOTE': '1', 09:12:31 INFO - 'NO_EM_RESTART': '1', 09:12:31 INFO - 'PAGER': '/bin/cat', 09:12:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:31 INFO - 'PWD': '/builds/slave/test', 09:12:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:31 INFO - 'SHELL': '/bin/bash', 09:12:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYgnY2HSdv/Listeners', 09:12:31 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 09:12:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:31 INFO - 'USER': 'cltbld', 09:12:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:31 INFO - 'XPC_FLAGS': '0x0', 09:12:31 INFO - 'XPC_SERVICE_NAME': '0', 09:12:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:31 INFO - Downloading/unpacking psutil>=0.7.1 09:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:12:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:34 INFO - Installing collected packages: psutil 09:12:34 INFO - Running setup.py install for psutil 09:12:34 INFO - building 'psutil._psutil_osx' extension 09:12:34 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 09:12:35 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 09:12:35 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 09:12:35 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 09:12:35 INFO - building 'psutil._psutil_posix' extension 09:12:35 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 09:12:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:12:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:12:35 INFO - ^ 09:12:35 INFO - 1 warning generated. 09:12:35 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 09:12:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:35 INFO - Successfully installed psutil 09:12:35 INFO - Cleaning up... 09:12:36 INFO - Return code: 0 09:12:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:36 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 0x10d384a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d394420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd8c91390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d223e00>, '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 0x10d08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21eb20>, '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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09:12:36 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 09:12:36 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 09:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EAC4iOh9T7/Render', 09:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:36 INFO - 'HOME': '/Users/cltbld', 09:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:36 INFO - 'LOGNAME': 'cltbld', 09:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:36 INFO - 'MOZ_NO_REMOTE': '1', 09:12:36 INFO - 'NO_EM_RESTART': '1', 09:12:36 INFO - 'PAGER': '/bin/cat', 09:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:36 INFO - 'PWD': '/builds/slave/test', 09:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:36 INFO - 'SHELL': '/bin/bash', 09:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYgnY2HSdv/Listeners', 09:12:36 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 09:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:36 INFO - 'USER': 'cltbld', 09:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:36 INFO - 'XPC_FLAGS': '0x0', 09:12:36 INFO - 'XPC_SERVICE_NAME': '0', 09:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:12:36 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 09:12:36 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 09:12:36 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 09:12:36 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 09:12:36 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 09:12:36 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 09:12:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:12:38 INFO - Installing collected packages: mozsystemmonitor 09:12:38 INFO - Running setup.py install for mozsystemmonitor 09:12:38 INFO - Successfully installed mozsystemmonitor 09:12:38 INFO - Cleaning up... 09:12:39 INFO - Return code: 0 09:12:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d384a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d394420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd8c91390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d223e00>, '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 0x10d08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21eb20>, '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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:12:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EAC4iOh9T7/Render', 09:12:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:39 INFO - 'HOME': '/Users/cltbld', 09:12:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:39 INFO - 'LOGNAME': 'cltbld', 09:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:39 INFO - 'MOZ_NO_REMOTE': '1', 09:12:39 INFO - 'NO_EM_RESTART': '1', 09:12:39 INFO - 'PAGER': '/bin/cat', 09:12:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:39 INFO - 'PWD': '/builds/slave/test', 09:12:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:39 INFO - 'SHELL': '/bin/bash', 09:12:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYgnY2HSdv/Listeners', 09:12:39 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 09:12:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:39 INFO - 'USER': 'cltbld', 09:12:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:39 INFO - 'XPC_FLAGS': '0x0', 09:12:39 INFO - 'XPC_SERVICE_NAME': '0', 09:12:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:39 INFO - Downloading/unpacking blobuploader==1.2.4 09:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:12:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:12:41 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 09:12:41 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 09:12:41 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 09:12:41 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 09:12:41 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 09:12:41 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 09:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:12:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:42 INFO - Downloading docopt-0.6.1.tar.gz 09:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:12:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:12:42 INFO - Running setup.py install for blobuploader 09:12:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:12:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:12:43 INFO - Running setup.py install for requests 09:12:43 INFO - Running setup.py install for docopt 09:12:43 INFO - Successfully installed blobuploader requests docopt 09:12:43 INFO - Cleaning up... 09:12:43 INFO - Return code: 0 09:12:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:43 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 0x10d384a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d394420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd8c91390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d223e00>, '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 0x10d08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21eb20>, '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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09:12:43 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 09:12:43 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 09:12:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EAC4iOh9T7/Render', 09:12:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:43 INFO - 'HOME': '/Users/cltbld', 09:12:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:43 INFO - 'LOGNAME': 'cltbld', 09:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:43 INFO - 'MOZ_NO_REMOTE': '1', 09:12:43 INFO - 'NO_EM_RESTART': '1', 09:12:43 INFO - 'PAGER': '/bin/cat', 09:12:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:43 INFO - 'PWD': '/builds/slave/test', 09:12:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:43 INFO - 'SHELL': '/bin/bash', 09:12:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYgnY2HSdv/Listeners', 09:12:43 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 09:12:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:43 INFO - 'USER': 'cltbld', 09:12:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:43 INFO - 'XPC_FLAGS': '0x0', 09:12:43 INFO - 'XPC_SERVICE_NAME': '0', 09:12:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-w6Wt6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-4fgCMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-y2XQ64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-F7dOkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-TCCrvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ryYFPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-lRh9ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-IWBJCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-zCqACI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-xrZt4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:45 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Fjtze0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:45 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-JdMATV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:45 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-_tDBj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:45 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ilVVIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:45 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-G7gRID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:45 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-HsuxBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:45 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-fibm12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:12:45 INFO - Running setup.py install for manifestparser 09:12:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:12:45 INFO - Running setup.py install for mozcrash 09:12:46 INFO - Running setup.py install for mozdebug 09:12:46 INFO - Running setup.py install for mozdevice 09:12:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Running setup.py install for mozfile 09:12:46 INFO - Running setup.py install for mozhttpd 09:12:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Running setup.py install for mozinfo 09:12:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Running setup.py install for mozInstall 09:12:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:12:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for mozleak 09:12:47 INFO - Running setup.py install for mozlog 09:12:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for moznetwork 09:12:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for mozprocess 09:12:47 INFO - Running setup.py install for mozprofile 09:12:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for mozrunner 09:12:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:12:47 INFO - Running setup.py install for mozscreenshot 09:12:48 INFO - Running setup.py install for moztest 09:12:48 INFO - Running setup.py install for mozversion 09:12:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:12:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:12:48 INFO - Cleaning up... 09:12:48 INFO - Return code: 0 09:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:48 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')]} 09:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:48 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')]} 09:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:48 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 0x10d384a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d394420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd8c91390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d223e00>, '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 0x10d08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21eb20>, '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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09:12:48 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 09:12:48 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 09:12:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EAC4iOh9T7/Render', 09:12:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:48 INFO - 'HOME': '/Users/cltbld', 09:12:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:48 INFO - 'LOGNAME': 'cltbld', 09:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:48 INFO - 'MOZ_NO_REMOTE': '1', 09:12:48 INFO - 'NO_EM_RESTART': '1', 09:12:48 INFO - 'PAGER': '/bin/cat', 09:12:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:48 INFO - 'PWD': '/builds/slave/test', 09:12:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:48 INFO - 'SHELL': '/bin/bash', 09:12:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYgnY2HSdv/Listeners', 09:12:48 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 09:12:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:48 INFO - 'USER': 'cltbld', 09:12:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:48 INFO - 'XPC_FLAGS': '0x0', 09:12:48 INFO - 'XPC_SERVICE_NAME': '0', 09:12:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-gilHPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:48 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)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-2iXstt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:48 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)) 09:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-iSxGfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:49 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)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-hESDU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:49 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)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-276i_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:49 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)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-AmQXtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:49 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)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-rQ2NkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:49 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)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-jXdex3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:49 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)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-cPXWuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:49 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)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-lozn_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:49 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)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-oMTvBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:49 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)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-MxkiRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:49 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)) 09:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-sbfcaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:50 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)) 09:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:50 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ieOJW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:50 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)) 09:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:50 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-oH_HSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:50 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)) 09:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:50 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-jUxkwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:50 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)) 09:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:50 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-nmISsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:50 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)) 09:12:50 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)) 09:12:50 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)) 09:12:50 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)) 09:12:50 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)) 09:12:50 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)) 09:12:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:52 INFO - Downloading blessings-1.6.tar.gz 09:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:12:52 INFO - Installing collected packages: blessings 09:12:52 INFO - Running setup.py install for blessings 09:12:53 INFO - Successfully installed blessings 09:12:53 INFO - Cleaning up... 09:12:53 INFO - Return code: 0 09:12:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:53 INFO - Reading from file tmpfile_stdout 09:12:53 INFO - Current package versions: 09:12:53 INFO - blessings == 1.6 09:12:53 INFO - blobuploader == 1.2.4 09:12:53 INFO - docopt == 0.6.1 09:12:53 INFO - manifestparser == 1.1 09:12:53 INFO - mozInstall == 1.12 09:12:53 INFO - mozcrash == 0.17 09:12:53 INFO - mozdebug == 0.1 09:12:53 INFO - mozdevice == 0.48 09:12:53 INFO - mozfile == 1.2 09:12:53 INFO - mozhttpd == 0.7 09:12:53 INFO - mozinfo == 0.9 09:12:53 INFO - mozleak == 0.1 09:12:53 INFO - mozlog == 3.1 09:12:53 INFO - moznetwork == 0.27 09:12:53 INFO - mozprocess == 0.22 09:12:53 INFO - mozprofile == 0.28 09:12:53 INFO - mozrunner == 6.11 09:12:53 INFO - mozscreenshot == 0.1 09:12:53 INFO - mozsystemmonitor == 0.0 09:12:53 INFO - moztest == 0.7 09:12:53 INFO - mozversion == 1.4 09:12:53 INFO - psutil == 3.1.1 09:12:53 INFO - requests == 1.2.3 09:12:53 INFO - wsgiref == 0.1.2 09:12:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:53 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 0x10d384a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d394420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd8c91390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d223e00>, '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 0x10d08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21eb20>, '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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09:12:53 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 09:12:53 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 09:12:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EAC4iOh9T7/Render', 09:12:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:53 INFO - 'HOME': '/Users/cltbld', 09:12:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:53 INFO - 'LOGNAME': 'cltbld', 09:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:53 INFO - 'MOZ_NO_REMOTE': '1', 09:12:53 INFO - 'NO_EM_RESTART': '1', 09:12:53 INFO - 'PAGER': '/bin/cat', 09:12:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:53 INFO - 'PWD': '/builds/slave/test', 09:12:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:53 INFO - 'SHELL': '/bin/bash', 09:12:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYgnY2HSdv/Listeners', 09:12:53 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 09:12:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:53 INFO - 'USER': 'cltbld', 09:12:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:53 INFO - 'XPC_FLAGS': '0x0', 09:12:53 INFO - 'XPC_SERVICE_NAME': '0', 09:12:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:53 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)) 09:12:53 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)) 09:12:53 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)) 09:12:53 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)) 09:12:53 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)) 09:12:53 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)) 09:12:53 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)) 09:12:53 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)) 09:12:53 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)) 09:12:53 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)) 09:12:53 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)) 09:12:53 INFO - Cleaning up... 09:12:53 INFO - Return code: 0 09:12:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d384a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d394420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd8c91390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d223e00>, '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 0x10d08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21eb20>, '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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09:12: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', 'jsonschema'] in /builds/slave/test/build 09:12: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 jsonschema 09:12:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EAC4iOh9T7/Render', 09:12:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:53 INFO - 'HOME': '/Users/cltbld', 09:12:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:53 INFO - 'LOGNAME': 'cltbld', 09:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:53 INFO - 'MOZ_NO_REMOTE': '1', 09:12:53 INFO - 'NO_EM_RESTART': '1', 09:12:53 INFO - 'PAGER': '/bin/cat', 09:12:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:53 INFO - 'PWD': '/builds/slave/test', 09:12:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:53 INFO - 'SHELL': '/bin/bash', 09:12:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYgnY2HSdv/Listeners', 09:12:53 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 09:12:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:53 INFO - 'USER': 'cltbld', 09:12:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:53 INFO - 'XPC_FLAGS': '0x0', 09:12:53 INFO - 'XPC_SERVICE_NAME': '0', 09:12:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:54 INFO - Downloading/unpacking jsonschema 09:12:54 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 09:12:54 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 09:12:54 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 09:12:54 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 09:12:54 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 09:12:54 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 09:12:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:12:56 INFO - Downloading/unpacking functools32 (from jsonschema) 09:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:12:56 INFO - warning: no files found matching '*.txt' 09:12:56 INFO - no previously-included directories found matching 'build' 09:12:56 INFO - no previously-included directories found matching 'dist' 09:12:56 INFO - no previously-included directories found matching '.git*' 09:12:56 INFO - Installing collected packages: jsonschema, functools32 09:12:56 INFO - Running setup.py install for functools32 09:12:57 INFO - warning: no files found matching '*.txt' 09:12:57 INFO - no previously-included directories found matching 'build' 09:12:57 INFO - no previously-included directories found matching 'dist' 09:12:57 INFO - no previously-included directories found matching '.git*' 09:12:57 INFO - Successfully installed jsonschema functools32 09:12:57 INFO - Cleaning up... 09:12:57 INFO - Return code: 0 09:12:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d384a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d394420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedd8c91390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d223e00>, '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 0x10d08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21eb20>, '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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 09:12: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', 'flake8'] in /builds/slave/test/build 09:12: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 flake8 09:12:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EAC4iOh9T7/Render', 09:12:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:57 INFO - 'HOME': '/Users/cltbld', 09:12:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:57 INFO - 'LOGNAME': 'cltbld', 09:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:57 INFO - 'MOZ_NO_REMOTE': '1', 09:12:57 INFO - 'NO_EM_RESTART': '1', 09:12:57 INFO - 'PAGER': '/bin/cat', 09:12:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:57 INFO - 'PWD': '/builds/slave/test', 09:12:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:57 INFO - 'SHELL': '/bin/bash', 09:12:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYgnY2HSdv/Listeners', 09:12:57 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 09:12:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:57 INFO - 'USER': 'cltbld', 09:12:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:57 INFO - 'XPC_FLAGS': '0x0', 09:12:57 INFO - 'XPC_SERVICE_NAME': '0', 09:12:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:57 INFO - Downloading/unpacking flake8 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12: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 09:12:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:12:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:12:59 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 09:12:59 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 09:12:59 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 09:12:59 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 09:12:59 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 09:12:59 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 09:13:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:13:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:13:01 INFO - no previously-included directories found matching 'docs/_build' 09:13:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:13:01 INFO - Running setup.py install for pep8 09:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:13:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:13:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:13:01 INFO - no previously-included directories found matching 'docs/_build' 09:13:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:13:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:13:01 INFO - Cleaning up... 09:13:01 INFO - Return code: 0 09:13:01 INFO - Running post-action listener: _resource_record_post_action 09:13:01 INFO - Running post-action listener: _start_resource_monitoring 09:13:01 INFO - Starting resource monitoring. 09:13:01 INFO - ##### 09:13:01 INFO - ##### Running install step. 09:13:01 INFO - ##### 09:13:01 INFO - Running pre-action listener: _resource_record_pre_action 09:13:01 INFO - Running main action method: install 09:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:13:01 INFO - Reading from file tmpfile_stdout 09:13:01 INFO - Detecting whether we're running mozinstall >=1.0... 09:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:13:01 INFO - Reading from file tmpfile_stdout 09:13:01 INFO - Output received: 09:13:01 INFO - Usage: mozinstall [options] installer 09:13:01 INFO - Options: 09:13:01 INFO - -h, --help show this help message and exit 09:13:01 INFO - -d DEST, --destination=DEST 09:13:01 INFO - Directory to install application into. [default: 09:13:01 INFO - "/builds/slave/test"] 09:13:01 INFO - --app=APP Application being installed. [default: firefox] 09:13:01 INFO - mkdir: /builds/slave/test/build/application 09:13:01 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'] 09:13:01 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 09:13:35 INFO - Reading from file tmpfile_stdout 09:13:35 INFO - Output received: 09:13:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:13:35 INFO - Running post-action listener: _resource_record_post_action 09:13:35 INFO - ##### 09:13:35 INFO - ##### Running run-tests step. 09:13:35 INFO - ##### 09:13:35 INFO - Running pre-action listener: _resource_record_pre_action 09:13:35 INFO - Running main action method: run_tests 09:13:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:13:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:13:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:13:35 INFO - 2016-03-18 09:13:35.309 screenresolution[1641:7479] starting screenresolution argv=screenresolution get 09:13:35 INFO - 2016-03-18 09:13:35.311 screenresolution[1641:7479] Display 0: 1600x1200x32@60 09:13:35 INFO - 2016-03-18 09:13:35.317 screenresolution[1642:7481] starting screenresolution argv=screenresolution list 09:13:35 INFO - Available Modes on Display 0 09:13:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:13:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:13:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:13:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:13:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:13:35 INFO - Intel Iris: 09:13:35 INFO - Chipset Model: Intel Iris 09:13:35 INFO - Type: GPU 09:13:35 INFO - Bus: Built-In 09:13:35 INFO - VRAM (Dynamic, Max): 1536 MB 09:13:35 INFO - Vendor: Intel (0x8086) 09:13:35 INFO - Device ID: 0x0a2e 09:13:35 INFO - Revision ID: 0x0009 09:13:35 INFO - Displays: 09:13:35 INFO - Display: 09:13:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:13:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:13:35 INFO - Display Serial Number: 1600x1200 60 09:13:35 INFO - Main Display: Yes 09:13:35 INFO - Mirror: Off 09:13:35 INFO - Online: Yes 09:13:35 INFO - Rotation: Supported 09:13:35 INFO - Return code: 0 09:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:13:35 INFO - Python 2.7.3 09:13:35 INFO - Return code: 0 09:13:35 INFO - grabbing minidump binary from tooltool 09:13:35 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')]} 09:13:35 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 0x10d223e00>, '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 0x10d08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d21eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:13:35 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 09:13:35 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 09:13:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:13:35 INFO - Return code: 0 09:13:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:13:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:13:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:13:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:13:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:13:36 INFO - Return code: 0 09:13:36 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 09:13:36 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --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 09:13:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EAC4iOh9T7/Render', 09:13:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:36 INFO - 'HOME': '/Users/cltbld', 09:13:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:36 INFO - 'LOGNAME': 'cltbld', 09:13:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:13:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:36 INFO - 'MOZ_NO_REMOTE': '1', 09:13:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:13:36 INFO - 'NO_EM_RESTART': '1', 09:13:36 INFO - 'PAGER': '/bin/cat', 09:13:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:36 INFO - 'PWD': '/builds/slave/test', 09:13:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:13:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:36 INFO - 'SHELL': '/bin/bash', 09:13:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYgnY2HSdv/Listeners', 09:13:36 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 09:13:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:36 INFO - 'USER': 'cltbld', 09:13:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:36 INFO - 'XPC_FLAGS': '0x0', 09:13:36 INFO - 'XPC_SERVICE_NAME': '0', 09:13:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:36 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 09:13:37 INFO - mozversion application_buildid: 20160318073312 09:13:37 INFO - mozversion application_changeset: 3d37c7e5b8dd28a4a017e2296e824619f9379b88 09:13:37 INFO - mozversion application_display_name: Nightly 09:13:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:13:37 INFO - mozversion application_name: Firefox 09:13:37 INFO - mozversion application_remotingname: firefox 09:13:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:13:37 INFO - mozversion application_vendor: Mozilla 09:13:37 INFO - mozversion application_version: 48.0a1 09:13:37 INFO - mozversion platform_buildid: 20160318073312 09:13:37 INFO - mozversion platform_changeset: 3d37c7e5b8dd28a4a017e2296e824619f9379b88 09:13:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:13:37 INFO - mozversion platform_version: 48.0a1 09:13:37 INFO - using testdate: 1458317617 09:13:37 INFO - actual date: 1458317617 09:13:37 INFO - starting webserver on 'localhost:49270' 09:13:37 INFO - SUITE-START | Running 2 tests 09:13:37 INFO - TEST-START | dromaeo_css 09:13:37 INFO - operating with platform_type : mac_ 09:13:37 INFO - Initialising browser for dromaeo_css test... 09:13:37 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmp5eBsok/profile http://localhost:49270/getInfo.html) 09:13:39 INFO - PROCESS | 1660 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.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] 09:13:39 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 09:13:39 INFO - PROCESS | 1660 | colorDepth:24 09:13:39 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 09:13:39 INFO - PROCESS | 1660 | __metrics 09:13:40 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 09:13:40 INFO - TEST-INFO | 1660: exit 0 09:13:40 INFO - Browser initialized. 09:13:40 INFO - Running cycle 1/1 for dromaeo_css test... 09:13:40 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmp5eBsok/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:52 INFO - PROCESS | 1664 | RSS: Main: 257265664 09:13:52 INFO - PROCESS | 1664 | 09:14:42 INFO - PROCESS | 1664 | 1458317682319 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] 09:16:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 09:16:53 INFO - PROCESS | 1664 | RSS: Main: 270180352 09:16:53 INFO - PROCESS | 1664 | 09:19:56 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 09:19:56 INFO - PROCESS | 1664 | RSS: Main: 281260032 09:19:56 INFO - PROCESS | 1664 | 09:22:58 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 09:22:58 INFO - PROCESS | 1664 | RSS: Main: 282619904 09:22:58 INFO - PROCESS | 1664 | 09:26:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 09:26:01 INFO - PROCESS | 1664 | RSS: Main: 283938816 09:26:01 INFO - PROCESS | 1664 | 09:29:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 09:29:04 INFO - PROCESS | 1664 | RSS: Main: 286048256 09:29:04 INFO - PROCESS | 1664 | 09:32:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 09:32:07 INFO - PROCESS | 1664 | RSS: Main: 288112640 09:32:07 INFO - PROCESS | 1664 | 09:32:07 INFO - PROCESS | 1664 | __start_tp_report 09:32:07 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 09:32:07 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 09:32:07 INFO - PROCESS | 1664 | |i|pagename|runs| 09:32:07 INFO - PROCESS | 1664 | |0;dojo.html;3548.7870727756335;3550.343186510495;3551.4850346699727;3574.499570060192;3638.3087213429462;5891.764329426828;5949.524038076955;5950.137230101638;5986.790462333819;5998.400159983999;5818.883622327551;5914.585978981473;5940.108983652454;5978.671173085479;6047.516198704104;5272.077386457364;5326.280952071479;5332.413434522219;5342.732863356836;5437.34751829781;218.11612130070748;4624.820670728976;5246.081935661263;5253.7373131343475;5298.417174110845;5259.237410575464;5328.147496400596;5352.197170424468;5353.491418315273;5372.409035006146;4163.292240319153;5339.145736682112;5367.221752845854;5384.67691938481;5409.891802163935;4893.951060489385;5213.374395072616;5259.5529380002745;5283.841484755463;5307.310049693554;4681.5318468153255;5687.772489100431;5719.971400143014;5793.102069179284;5812.447817457335;6159.599626024294;6171.598846075036;6190.84522886927;6217.595856269373;6229.190205273286;6197.535184861108;6218.4714299284615;6243.719032643542;6250.187475628185;6252.187215661935;6037.094435834616;6057.20361087237;6062.272527296753;6067.666278354689;6106.2061931948565;6170.629762214192;6342.904856427065;6406.711697973602;6470.0618410330235;6479.708413121421;5317.361916570037;6111.43980788641;6117.766507567544;6122.142899994004;6126.489111843539;6154.846128846814;6206.193194884636;6211.254649442006;6236.501079913596;6247.562670613013;6112.266528016667;6131.009681329197;6131.162586540493;6160.8767824643255;6212.4408803207925;6211.254649442096;6214.161088253028;6216.906746398808;6220.7869465454705;6254.155688981929;5004.524570165829;5014.047331007097;5015.548600625962;5026.924596131061;5056.241563765465;4434.162136232813;4463.955360446419;4513.277875539898;4554.544545545486;4581.679282450196;4981.825636102792;5855.590108692436;5856.472917437451;5946.970265148733;5948.821535353946;6182;6196.380361963767;6216.409441103088;6234;6235.657038862815;5859.882802344015;5955.553333500005;5996.730147143389;6005.309389420273;6024.277086749618;5514.696691681996;5519.558435325164;5531.446855314517;5535.8339249821765;5581.190727344512;6550.0829883816305;6564.179477565304;6576.375244351779;6603.6037837730855;6641.535092543476;6124.167343420691;6127.172831667668;6164.969175154096;6200.946617937861;6269.279032911274;6470.38531339522;6540.705668244846;6547.247066587213;6548.901766473602;6561.40947314744;6126.938730612636;6159.6612186330185;6167.1366008759705;6173.043178307369;6178.691065446799;5358.22305765654;6078.939210608014;6097.101247990999;6126.975740326223;6211.9689401552705;6188;6204.317525072329;6238.844028899314;6253.843653908689;6263.530235232467;6205.906911396423;6206.862306966511;6208.751649933952;6254.874902502015;6271.184745983175;5107.310513080686;5991.520678345809;6086.543509236736;6145.0782382642965;6146.508279337731;6199.721012554536;6227.128202051807;6240.375962403723;6244.313125556276;6276.811695649138;6016.187814645142;6169.629822210682;6211.13044173807;6220.160278362363;6225.159603453657 09:32:07 INFO - PROCESS | 1664 | |1;ext.html;474.8599163246842;565.2877374508118;575.8712922671566;640.2541039688762;649.6459429610861;34730.13174670628;36529.26941461173;37154.62845371546;38990.02524936878;39033.02417439562;40209.19581608373;40784.79607601965;40807.59192408075;40808.18383632325;40844.77465676027;8435.114312997139;9391.577379017943;9505.382150160218;9616.90383096167;9618.903810961905;9357.39176953496;9543.713688589354;9582.952085239598;9594.472304023277;9615.471149086798;9535.47554884481;9579.425234485918;9652.95173524135;9659.082387173208;9672.371295865782;9566.904330956671;9600.423974561549;9603.18372938301;9613.327067105305;9627.13355797978;9472.242220622335;9607.615695372177;9607.855882161773;9609.855852162224;9639.421634701941;32904.01287961365;39337.80331098326;39383.8030809847;39593.01017474557;39626.009349766486;3097.566340712302;3184.7770656054086;3224.3873664003763;3451;3492.7205823534055;28155;28719.28201794951;29264.707352926413;29265.85367073151;30181.09456716302;2608.7738762781464;2776.7917406194615;2784.3874347643687;2818.2672505148603;2889.3495724281;501175;505762;506062.4696876492;507943.92056079337;509154;46200.07599848051;47101.5289847104;71564;73025.6348718253;73238;45511.317330240076;45661.543384566394;45814.77092614515;45848.54151458442;45874.77062614666;15386.846131538765;15676.372945082298;15724.820638452162;15808.762868556982;15832;12544.498220071095;12635.620931372074;12714.237145771283;12720.809187862189;12756.234625922474;14657.633559160893;14721.55835324942;14729.705405892037;15148;15279.159646219343;6326.5255105867245;6441.774537891151;6492.123563318892;6512.023196520559;6518.869622607616;962.2302158273493;979.7599588100961;981.6564202529057;1109.955601775936;1150.4362862197631;29413.411731765675;29858.850705746332;30319.93880214226;30663.84668076645;31208.843955780078;1032.6127702111708;1072.5816931396762;1083.34999000599;1110.9055730262858;1124.814405623063;12457;13520.797188042186;13942.581722548137;14108.858911410754;15452.690946181014;529449;529929;530153;533376;534139;61661.383386165566;61954.380456195766;62017.379826202065;62041;62132.68933655303;1232.186756740547;1443.2134486704772;1473.3811799044427;1484.6733718581895;1492.9328180231917;29554.556681649363;29729.851350743975;29914.102576922727;30296.242593935327;30307.242318942204;54084.377468676;54639.45360546344;54951.72524137354;55068;55218.89562208814;493396;493936;495619;496068;497108;34156.82921585376;34374;34531.48202777011;45444.545554544035;46262.768686156356;44103.77948110367;44154.337684935395;44697;45221.32168017548;47255.29117063316;36530.90407287786;38851;39028.219435611696;39364.2127157461;39729.80135099306;37796.24407511889;37875.81062094672;37947.051323717125;38203.23593528058;38974.80512597419;38188;38754.8373548794;39536.40695389514;40227.59772402356;40362.9909252271;29110.854445727637;31440.838741887168;31700.685023773804;31813.68186318107;31862.044138675876;20216.898915505328;24115.517689646458;24137.396565086012;24389.3902652428;24607.50784984326 09:32:07 INFO - PROCESS | 1664 | |2;jquery.html;351.8997085830539;361.2558130251681;366.44849501500255;366.9779813211209;369.2633196772438;19441.027948602565;19635.509112272182;20483.283085092007;20717;20769.584608307825;20467.795322046775;20576.279830205945;20873.895630521863;21015.894920525414;21086.578268434623;5740.770369185238;5963.582549221556;6000;6004.729787159588;6037.547183961198;4337.1325734853;4429.60133587977;5824.359320474744;6514.739410423601;6525.575837570566;6351.269603995554;6429.260635026962;6440.967795161017;6444.838879028039;6462;6286.559940804145;6395.52033597482;6463.062855885917;6467.773627923048;6473.28793832678;5475.233467314579;5497;5577.832665020056;5581;5589.608727389084;24201;24740.010399584175;24914.750852491423;25158.622620660706;25406.745932540623;2143.753468351144;2195.560887822426;2216.390492614528;2446.645236440724;2743.986280068607;13735.733603955336;14233.572992810232;14305.14169149844;14351.928240358731;14661.6334591635;1713.4773893962335;1725.1460527039071;1729.9827001730073;1757.0863151161452;1758.7098128808732;93816;95376.0462395381;95645;95957.52021239919;96060.51969740176;9302;10250.487475626189;10335;10381.480925953672;10725.302855314536;11491.425428728697;11764.176507644383;12741.10812243134;12786.936065319614;12789.424475898606;8497.660093596187;8604;8629;8691.521966291915;8794.42836215644;8821;8858.42420242695;8961.283097352196;8979.775505612412;9053.68312109073;6060.151578778975;6132.41742034506;6189.288231853395;6191.318954914956;6199.535034872402;1788.1685016467404;1814.2108182940462;1821.417146513103;1822.3986084592052;1837.109002133964;960.6349587156835;966.6713317472094;989.5497548615363;992.6525715999487;1060.4644654449608;20228.221431372338;20570.38288851337;20638.07128679183;20704.689429658567;20905;892.2549671024767;941.6139382852997;961.5240455974338;1034.1881622925966;1097.226455348977;9390;11329.433528323716;11377.2604780689;11378.715532111764;11389.974902258837;647491;649393;649876;652086;653812;95722;97719;99358.00641993633;101227.49386253022;101520.49239753754;1064.8243039898484;1069.0912724184536;1088.1892989722548;1089.2048804372694;1093.2893619147458;17382.91308543449;18063;18503.629927401107;18540.907295463436;18778.624427511648;44981.775091124335;46059.848503787674;46776.298355525374;46911.76544117394;47995.52004479911;49241.75379123082;60872.39127608667;63124;64431.35568644441;65176.044718658515;7729.845403092019;7840.372770178258;7896.84206315882;8001.959990200012;8081.595920203848;11806.704832379259;12068.75862482763;12337.198082124632;12545.811812822998;12724;10059.36082185754;10649.467526623483;10876.728081798019;10928.950856596304;11047.392393418118;7027.508074434945;7579.583122928292;7827.491213071132;8001.799955001172;8011.39914506426;4053.8175782090466;7498.250174982458;7938.3252423544645;8083.474574152661;8196;10797.946010269898;10905.83641245366;10941.343519388862;11000.339639981325;11054.336739795637;11456.541738330374;11579.015783658484;11786.46960886745;11910.987566056981;12007.39963001829 09:32:07 INFO - PROCESS | 1664 | |3;mootools.html;1605.9277332520035;1626.9999999999995;1937.3509874192146;2007.769106552746;2009.4273132157339;8082.353411727063;8717.520536370514;8789.956050219747;9005.27957763379;9057.954710226448;8781.692640757576;8812.986506551748;8891;8918.019017908042;8930.151635594624;2467.777899988996;2477.702675678921;2482.156066937241;2485.490474452733;2501.024600405843;2408.9759102409016;2456.631505274205;2483.292261705414;2495.089292408276;2499.0378704198924;2110.841686873483;2148.258850696507;2442.4016116051594;2463.19946017545;2487.6890388701413;2439.256026911791;2464.088287333698;2479.3677612208953;2482.342179322472;2500.0749722602573;2502.2618327593223;2508.172303139978;2517.5342561626157;2518.659980902573;2519.6976362836576;8929.062448442884;9018.278537717033;9036.819263614756;9102.77243068922;9106.77233069172;5512.145617429305;5524.530414914737;5669.914951275734;5732.5987180897355;5733.140028995643;3625.1299688074937;3702.777833329982;3724.0131365188245;3734.9439758403646;3771.830267637963;1060.1624716473975;1077.175960390302;1078.5254488025323;1092.7104317355906;1095.8684957805035;12154.878451215463;12203.084768642388;12281.447334869952;12289.446974886152;12291.69270768229;3961.870866803005;4124.670026397881;4864;4926.729029903318;4931.50684931504;10387.324823886423;10402.375857448576;10405;10405.9479702601;10411.583536658449;5529.225908372831;5548.722563871871;5581.581381396411;5593;5600.355959064678;4483.3723278741;4829.517048295213;4879.658423910292;4918.065567542156;5016.247562865599;3918.294706952776;4000.419939108871;4009.919801603952;4051;4099.692523060782;1253.2042153232762;1326.5688651188402;1327.1904138475522;1330.2151730479063;1335.5726167626267;1344.6974430753003;1352.2427440633278;1363.0935427940508;1370.1778932640536;1372.0875617714307;8426.452280601741;8432.957835210786;8451.112633173429;8471.872921906177;8573;471.3824889394904;515.8942416804546;531.3597115475842;531.3676724697598;532.9147336426154;6158.876822463526;6256.343083976208;6282.089097080898;6362.713677884506;6376.872462550723;10786.838197427045;10962.342259464458;10967.287126336763;11036.724081898017;11166.553337866557;10602.416867072385;10731.731706707238;10768.676939691823;10854.371844223271;10902.236843421044;8370.372222083368;8476.703315383931;8483.490990540464;8529.360297977677;8588.828223435496;6265.310815810166;6547.508936829661;7192.784216473514;8080;8141.348692104499;7783.688652453839;9605.231581473325;9628.277879158952;9733.172680322252;9829;9792.951035244778;10071.244656650633;10152.137068349273;10192.847107293248;10202.540885660015;7569.886451703339;7575.0909890813455;7600.581967991813;7676.3091321779075;7729.768106956801;8406.117357677356;8418.494890306602;8421.4947103174;8431.325493960347;8481.660733570588;6673;7608.16310205888;7703.730369437043;7718.228177182237;7756.3019328260725;6279.874402511833;6790.456763458813;7490.838919967414;7538.3969282458365;7632.084149902047;7408.666610002455;7505.924940750522;7539.132999705104;7558.01745773046;7565.848683026419;7126.429885609243;7174.42604591621;7214.350708436266;7237.710491580277;7257.818554536178;7267.818304542428;7301.123865136217;7307.3058059484265;7345;7353.080864891888 09:32:07 INFO - PROCESS | 1664 | |4;prototype.html;326.572190430536;329.78069583726824;334.6603197754278;338.5480383687777;339.451785366633;5503.394626591077;6770.255271920091;6823.078884350612;6837.974303854418;6898.620575868325;5795.739191736371;6529.8367540811505;6739.730410783575;6778.152730908637;6786.219584747755;4131.814068366915;4750.5724484796365;4854.781534830923;4957.677750946195;5059.974700126494;4944.110060189165;4951.084049450863;4966.1309270877455;4975.601951843862;4996.325496058022;4893.363862697862;4895.853124406256;4895.926561101586;4929.876753081184;4937.728424936627;4903.877403064934;4907.852764417074;4926.778294976717;4929.8028078876805;4934.827281045146;4256.127493863751;4263.680223983182;4263.893402664927;4276.48682158143;4292.420523229355;6177.722002509898;6393.168888044571;6418.711157997901;6433.163688720483;6445.774397896051;5864.413558644144;5898.439648233454;5935.851603709899;5941.19793827832;5974.462298393166;7184.497085204038;7221.133463984303;7231;7232.37271613888;7293.671784769698;4794.328793968847;4803.0874133914795;4835.685680430761;4842.273658951185;4843.9031219375765;6927.134108236471;7027.262137475594;7701.3068823806125;7744.690212391498;7768.7669369918995;4724.456687480915;4881.048195601824;4912.778924948386;4921.975390123026;4931.334269873593;4675.602573781199;4960.652754307164;5011.84964451067;5019.247112933089;5027.4721154279005;5915.112733090071;5928.644281343133;5929.080992446092;5950.523958083343;5966.343702192756;7308.269173082649;7312.817179570447;7317.26827317264;7340.0457940467395;7374;1724.5860993361753;1745.746866704346;1751.0281793604418;1751.7897852257556;1753.7457068724964;1101.9008289254007;1144.376314908377;1147;1149.6608500492375;1160.3096157786272;5141.922871156936;5520.254765606592;6406.519511036691;6597.274299827015;6809.965950170316;6152.753889844445;7484.663190156456;7510.849783004419;7522.172561018284;7531.435142364345;6566.179227596551;6673.399394054559;6883.105196324445;6907.274736152732;6932.584044957319;3966.504186976628;4033.979830100831;4035.8991025224605;4048.291548978917;4060.127072679388;7968.0039995000625;7984.08183058944;8000.119986801447;8006.159353267823;8021.598920053974;7486.737964171228;7845.37237021037;7848.489848159851;7879.212078792075;7885.250901164381;6620.304867988792;7901.446898717149;7930.722424715107;7979.5611241382285;7992.320652744465;6162.537809664383;7570.205128461433;7586.468947173645;7668.309852113337;7675.462717609714;7445.9255407445235;7465.589392583242;7484.513506622052;7491;7493.737719179802;7682.7311044113185;7945.364370850433;7950.403719720928;7990.600469976362;7997.7600671979935;4293.935590966075;4401.185780630593;4680.4149481314835;4725.173094708343;4747.881302967454;7570.772876813704;7579.54522728638;7585.279398457138;7591;7592.696292148252;6165.907511387243;7102.899050647158;7318.96340518294;7336.7065317386705;7349.70601175947;7030.367266945795;7294.525855819355;7315.743948961974;7338.633068346455;7349.978755842186;7116.181639111568;7163.098944927313;7172.820679483055;7179;7188.640567971476;7283.672234749555;7296.233895441114;7300.379467745089;7305.232950540117;7363.668634911334;7166.104236970379;7168;7169.964150179424;7174.210836808052;7177.031100801325 09:32:07 INFO - PROCESS | 1664 | |5;yui.html;611.5932904618429;650.9519673325948;682.7644462660382;691.8028361916853;703.4969996452536;13481.932590337046;13529.188248705072;14722.411103555858;14845;15074.49255074492;13079.476820927175;13243.602691919234;14313.42746290147;14335.068220565656;14398;753.9547627142362;909.9226565741903;918.3250311021394;933.7012156110047;948.7485816258697;925.0980294213122;932.0493097041015;935.7613808478862;937.704623043739;938.5025936253762;978.5303054533828;990.2869933647798;992.846108853129;992.9652462163825;993.6273897288517;965.5461932891529;977.6480467031898;983.1692220074026;983.6704703924194;986.9062439068313;733.3546479098412;736.1056316575333;737.6717360774458;745.1505283976271;746.1009483572283;15172.165530895796;15249.61875953099;15288.464903728316;15362.615934601612;15365.46220882275;12957.09300348976;12965.22208667483;12983.026273029465;13045.54340598084;13238.602841914759;10084.394936303772;10133.949330253376;10184.236182286359;10291.691249262534;10961.287516311493;3512.7892326460496;3566.5185199997927;3578;3580.4092324766384;3671.614480479538;58624;84055.57972210161;85302.19024812164;85959;86112;9403.858942115874;9437.952810235905;9476.810463790824;9647.71056868295;9755.317127801127;20831.958402079836;20938.790612093988;20945.162193512395;20946.685799713017;20977.58044839125;7285.635718214068;7419.666115024729;7443.925560744432;7472.589007604634;7507.951440218582;3946.743461674982;3962.643362097425;4041.413994970713;4055.371417430303;4061.5532291447917;3093.180307218589;3557.288542291552;3590.9102272442874;3606.1165014571598;3611;641.4804008752925;641.8427485266046;653.5229282623711;655.0861548140317;655.4625207330039;543.1418358992782;545.7298637174545;548.5392270492805;566.7619599768108;604.4137186928672;7774.455788094892;7804.180561041009;8703;8823.382363234641;8849;506.5618240222255;605.6638565596137;608.6287364707525;614.3426533608996;634.1819053421127;3238.481842905124;3787.5833658297565;3825.1775868187915;3920.0787814863484;3976.522817261889;88488.67266991;88745.66881496782;89950.55024724966;89990.55004724934;90861.54569227112;74370.25629743742;74495.62752186204;75066;75657;75983;65051.67474162599;65462.67268663626;66153.00770488447;66258.33741662522;67934.66032669805;7259.201487836228;7520.924790752022;7746.845063098819;7874.0157480314965;8544.615492302737;48278.517214828804;49902.750486247336;51130.48869511406;52831.20753188782;53215.20177197268;65932;66079.33920660731;66479.66760166168;67661;70594.64702676453;10989.780204396027;11065;11126.666200014013;11223.663290100983;11826.58606948787;11590.478428470571;11678.124140689652;11842.585509507126;11881.821772673244;11960.521579137085;11402.429878505876;11496.367699776592;11526.423678816192;11821.172517924007;11863.5201984725;11502.884971150515;11633.069354451793;11736.471858766205;11747.295162289947;12042.157049006486;11103.333799971704;11276.154288428237;11371.772564548828;12149.331786751813;12162;8844.292456603327;9112.95443522778;9119.042500537347;9303.813923721624;9493.905060949579;8658.78353041179;9191.448513089235;9436.905630943602;9636.994588027896;9779.608815647294 09:32:07 INFO - PROCESS | 1664 | __end_tp_report 09:32:07 INFO - PROCESS | 1664 | __start_cc_report 09:32:07 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,370 09:32:07 INFO - PROCESS | 1664 | __end_cc_report 09:32:07 INFO - PROCESS | 1664 | __startTimestamp1458318727032__endTimestamp 09:32:07 INFO - PROCESS | 1664 | 09:32:07 INFO - PROCESS | 1664 | ------- Summary: start ------- 09:32:07 INFO - PROCESS | 1664 | Number of tests: 6 09:32:07 INFO - PROCESS | 1664 | 09:32:07 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5779.03 Median:6106.21 stddev:779.30 (12.8%) stddev-sans-first:761.80 09:32:07 INFO - PROCESS | 1664 | Values: 3548.8 3550.3 3551.5 3574.5 3638.3 5891.8 5949.5 5950.1 5986.8 5998.4 5818.9 5914.6 5940.1 5978.7 6047.5 5272.1 5326.3 5332.4 5342.7 5437.3 218.1 4624.8 5246.1 5253.7 5298.4 5259.2 5328.1 5352.2 5353.5 5372.4 4163.3 5339.1 5367.2 5384.7 5409.9 4894.0 5213.4 5259.6 5283.8 5307.3 4681.5 5687.8 5720.0 5793.1 5812.4 6159.6 6171.6 6190.8 6217.6 6229.2 6197.5 6218.5 6243.7 6250.2 6252.2 6037.1 6057.2 6062.3 6067.7 6106.2 6170.6 6342.9 6406.7 6470.1 6479.7 5317.4 6111.4 6117.8 6122.1 6126.5 6154.8 6206.2 6211.3 6236.5 6247.6 6112.3 6131.0 6131.2 6160.9 6212.4 6211.3 6214.2 6216.9 6220.8 6254.2 5004.5 5014.0 5015.5 5026.9 5056.2 4434.2 4464.0 4513.3 4554.5 4581.7 4981.8 5855.6 5856.5 5947.0 5948.8 6182.0 6196.4 6216.4 6234.0 6235.7 5859.9 5955.6 5996.7 6005.3 6024.3 5514.7 5519.6 5531.4 5535.8 5581.2 6550.1 6564.2 6576.4 6603.6 6641.5 6124.2 6127.2 6165.0 6200.9 6269.3 6470.4 6540.7 6547.2 6548.9 6561.4 6126.9 6159.7 6167.1 6173.0 6178.7 5358.2 6078.9 6097.1 6127.0 6212.0 6188.0 6204.3 6238.8 6253.8 6263.5 6205.9 6206.9 6208.8 6254.9 6271.2 5107.3 5991.5 6086.5 6145.1 6146.5 6199.7 6227.1 6240.4 6244.3 6276.8 6016.2 6169.6 6211.1 6220.2 6225.2 09:32:07 INFO - PROCESS | 1664 | 09:32:07 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:64982.35 Median:39609.51 stddev:136066.43 (343.5%) stddev-sans-first:136361.93 09:32:07 INFO - PROCESS | 1664 | Values: 474.9 565.3 575.9 640.3 649.6 34730.1 36529.3 37154.6 38990.0 39033.0 40209.2 40784.8 40807.6 40808.2 40844.8 8435.1 9391.6 9505.4 9616.9 9618.9 9357.4 9543.7 9583.0 9594.5 9615.5 9535.5 9579.4 9653.0 9659.1 9672.4 9566.9 9600.4 9603.2 9613.3 9627.1 9472.2 9607.6 9607.9 9609.9 9639.4 32904.0 39337.8 39383.8 39593.0 39626.0 3097.6 3184.8 3224.4 3451.0 3492.7 28155.0 28719.3 29264.7 29265.9 30181.1 2608.8 2776.8 2784.4 2818.3 2889.3 501175.0 505762.0 506062.5 507943.9 509154.0 46200.1 47101.5 71564.0 73025.6 73238.0 45511.3 45661.5 45814.8 45848.5 45874.8 15386.8 15676.4 15724.8 15808.8 15832.0 12544.5 12635.6 12714.2 12720.8 12756.2 14657.6 14721.6 14729.7 15148.0 15279.2 6326.5 6441.8 6492.1 6512.0 6518.9 962.2 979.8 981.7 1110.0 1150.4 29413.4 29858.9 30319.9 30663.8 31208.8 1032.6 1072.6 1083.3 1110.9 1124.8 12457.0 13520.8 13942.6 14108.9 15452.7 529449.0 529929.0 530153.0 533376.0 534139.0 61661.4 61954.4 62017.4 62041.0 62132.7 1232.2 1443.2 1473.4 1484.7 1492.9 29554.6 29729.9 29914.1 30296.2 30307.2 54084.4 54639.5 54951.7 55068.0 55218.9 493396.0 493936.0 495619.0 496068.0 497108.0 34156.8 34374.0 34531.5 45444.5 46262.8 44103.8 44154.3 44697.0 45221.3 47255.3 36530.9 38851.0 39028.2 39364.2 39729.8 37796.2 37875.8 37947.1 38203.2 38974.8 38188.0 38754.8 39536.4 40227.6 40363.0 29110.9 31440.8 31700.7 31813.7 31862.0 20216.9 24115.5 24137.4 24389.4 24607.5 09:32:07 INFO - PROCESS | 1664 | 09:32:07 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:34333.42 Median:366.71 stddev:106943.43 (29162.7%) stddev-sans-first:107212.99 09:32:07 INFO - PROCESS | 1664 | Values: 351.9 361.3 366.4 367.0 369.3 19441.0 19635.5 20483.3 20717.0 20769.6 20467.8 20576.3 20873.9 21015.9 21086.6 5740.8 5963.6 6000.0 6004.7 6037.5 4337.1 4429.6 5824.4 6514.7 6525.6 6351.3 6429.3 6441.0 6444.8 6462.0 6286.6 6395.5 6463.1 6467.8 6473.3 5475.2 5497.0 5577.8 5581.0 5589.6 24201.0 24740.0 24914.8 25158.6 25406.7 2143.8 2195.6 2216.4 2446.6 2744.0 13735.7 14233.6 14305.1 14351.9 14661.6 1713.5 1725.1 1730.0 1757.1 1758.7 93816.0 95376.0 95645.0 95957.5 96060.5 9302.0 10250.5 10335.0 10381.5 10725.3 11491.4 11764.2 12741.1 12786.9 12789.4 8497.7 8604.0 8629.0 8691.5 8794.4 8821.0 8858.4 8961.3 8979.8 9053.7 6060.2 6132.4 6189.3 6191.3 6199.5 1788.2 1814.2 1821.4 1822.4 1837.1 960.6 966.7 989.5 992.7 1060.5 20228.2 20570.4 20638.1 20704.7 20905.0 892.3 941.6 961.5 1034.2 1097.2 9390.0 11329.4 11377.3 11378.7 11390.0 647491.0 649393.0 649876.0 652086.0 653812.0 95722.0 97719.0 99358.0 101227.5 101520.5 1064.8 1069.1 1088.2 1089.2 1093.3 17382.9 18063.0 18503.6 18540.9 18778.6 44981.8 46059.8 46776.3 46911.8 47995.5 49241.8 60872.4 63124.0 64431.4 65176.0 7729.8 7840.4 7896.8 8002.0 8081.6 11806.7 12068.8 12337.2 12545.8 12724.0 10059.4 10649.5 10876.7 10929.0 11047.4 7027.5 7579.6 7827.5 8001.8 8011.4 4053.8 7498.3 7938.3 8083.5 8196.0 10797.9 10905.8 10941.3 11000.3 11054.3 11456.5 11579.0 11786.5 11911.0 12007.4 09:32:07 INFO - PROCESS | 1664 | 09:32:07 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6121.14 Median:523.63 stddev:3269.07 (624.3%) stddev-sans-first:3260.63 09:32:07 INFO - PROCESS | 1664 | Values: 1605.9 1627.0 1937.4 2007.8 2009.4 8082.4 8717.5 8790.0 9005.3 9058.0 8781.7 8813.0 8891.0 8918.0 8930.2 2467.8 2477.7 2482.2 2485.5 2501.0 2409.0 2456.6 2483.3 2495.1 2499.0 2110.8 2148.3 2442.4 2463.2 2487.7 2439.3 2464.1 2479.4 2482.3 2500.1 2502.3 2508.2 2517.5 2518.7 2519.7 8929.1 9018.3 9036.8 9102.8 9106.8 5512.1 5524.5 5669.9 5732.6 5733.1 3625.1 3702.8 3724.0 3734.9 3771.8 1060.2 1077.2 1078.5 1092.7 1095.9 12154.9 12203.1 12281.4 12289.4 12291.7 3961.9 4124.7 4864.0 4926.7 4931.5 10387.3 10402.4 10405.0 10405.9 10411.6 5529.2 5548.7 5581.6 5593.0 5600.4 4483.4 4829.5 4879.7 4918.1 5016.2 3918.3 4000.4 4009.9 4051.0 4099.7 1253.2 1326.6 1327.2 1330.2 1335.6 1344.7 1352.2 1363.1 1370.2 1372.1 8426.5 8433.0 8451.1 8471.9 8573.0 471.4 515.9 531.4 531.4 532.9 6158.9 6256.3 6282.1 6362.7 6376.9 10786.8 10962.3 10967.3 11036.7 11166.6 10602.4 10731.7 10768.7 10854.4 10902.2 8370.4 8476.7 8483.5 8529.4 8588.8 6265.3 6547.5 7192.8 8080.0 8141.3 7783.7 9605.2 9628.3 9733.2 9829.0 9793.0 10071.2 10152.1 10192.8 10202.5 7569.9 7575.1 7600.6 7676.3 7729.8 8406.1 8418.5 8421.5 8431.3 8481.7 6673.0 7608.2 7703.7 7718.2 7756.3 6279.9 6790.5 7490.8 7538.4 7632.1 7408.7 7505.9 7539.1 7558.0 7565.8 7126.4 7174.4 7214.4 7237.7 7257.8 7267.8 7301.1 7307.3 7345.0 7353.1 09:32:07 INFO - PROCESS | 1664 | 09:32:07 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5929.68 Median:6608.79 stddev:1900.21 (28.8%) stddev-sans-first:1858.42 09:32:07 INFO - PROCESS | 1664 | Values: 326.6 329.8 334.7 338.5 339.5 5503.4 6770.3 6823.1 6838.0 6898.6 5795.7 6529.8 6739.7 6778.2 6786.2 4131.8 4750.6 4854.8 4957.7 5060.0 4944.1 4951.1 4966.1 4975.6 4996.3 4893.4 4895.9 4895.9 4929.9 4937.7 4903.9 4907.9 4926.8 4929.8 4934.8 4256.1 4263.7 4263.9 4276.5 4292.4 6177.7 6393.2 6418.7 6433.2 6445.8 5864.4 5898.4 5935.9 5941.2 5974.5 7184.5 7221.1 7231.0 7232.4 7293.7 4794.3 4803.1 4835.7 4842.3 4843.9 6927.1 7027.3 7701.3 7744.7 7768.8 4724.5 4881.0 4912.8 4922.0 4931.3 4675.6 4960.7 5011.8 5019.2 5027.5 5915.1 5928.6 5929.1 5950.5 5966.3 7308.3 7312.8 7317.3 7340.0 7374.0 1724.6 1745.7 1751.0 1751.8 1753.7 1101.9 1144.4 1147.0 1149.7 1160.3 5141.9 5520.3 6406.5 6597.3 6810.0 6152.8 7484.7 7510.8 7522.2 7531.4 6566.2 6673.4 6883.1 6907.3 6932.6 3966.5 4034.0 4035.9 4048.3 4060.1 7968.0 7984.1 8000.1 8006.2 8021.6 7486.7 7845.4 7848.5 7879.2 7885.3 6620.3 7901.4 7930.7 7979.6 7992.3 6162.5 7570.2 7586.5 7668.3 7675.5 7445.9 7465.6 7484.5 7491.0 7493.7 7682.7 7945.4 7950.4 7990.6 7997.8 4293.9 4401.2 4680.4 4725.2 4747.9 7570.8 7579.5 7585.3 7591.0 7592.7 6165.9 7102.9 7319.0 7336.7 7349.7 7030.4 7294.5 7315.7 7338.6 7350.0 7116.2 7163.1 7172.8 7179.0 7188.6 7283.7 7296.2 7300.4 7305.2 7363.7 7166.1 7168.0 7170.0 7174.2 7177.0 09:32:07 INFO - PROCESS | 1664 | 09:32:07 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18017.49 Median:624.26 stddev:25105.41 (4021.6%) stddev-sans-first:25141.82 09:32:07 INFO - PROCESS | 1664 | Values: 611.6 651.0 682.8 691.8 703.5 13481.9 13529.2 14722.4 14845.0 15074.5 13079.5 13243.6 14313.4 14335.1 14398.0 754.0 909.9 918.3 933.7 948.7 925.1 932.0 935.8 937.7 938.5 978.5 990.3 992.8 993.0 993.6 965.5 977.6 983.2 983.7 986.9 733.4 736.1 737.7 745.2 746.1 15172.2 15249.6 15288.5 15362.6 15365.5 12957.1 12965.2 12983.0 13045.5 13238.6 10084.4 10133.9 10184.2 10291.7 10961.3 3512.8 3566.5 3578.0 3580.4 3671.6 58624.0 84055.6 85302.2 85959.0 86112.0 9403.9 9438.0 9476.8 9647.7 9755.3 20832.0 20938.8 20945.2 20946.7 20977.6 7285.6 7419.7 7443.9 7472.6 7508.0 3946.7 3962.6 4041.4 4055.4 4061.6 3093.2 3557.3 3590.9 3606.1 3611.0 641.5 641.8 653.5 655.1 655.5 543.1 545.7 548.5 566.8 604.4 7774.5 7804.2 8703.0 8823.4 8849.0 506.6 605.7 608.6 614.3 634.2 3238.5 3787.6 3825.2 3920.1 3976.5 88488.7 88745.7 89950.6 89990.6 90861.5 74370.3 74495.6 75066.0 75657.0 75983.0 65051.7 65462.7 66153.0 66258.3 67934.7 7259.2 7520.9 7746.8 7874.0 8544.6 48278.5 49902.8 51130.5 52831.2 53215.2 65932.0 66079.3 66479.7 67661.0 70594.6 10989.8 11065.0 11126.7 11223.7 11826.6 11590.5 11678.1 11842.6 11881.8 11960.5 11402.4 11496.4 11526.4 11821.2 11863.5 11502.9 11633.1 11736.5 11747.3 12042.2 11103.3 11276.2 11371.8 12149.3 12162.0 8844.3 9113.0 9119.0 9303.8 9493.9 8658.8 9191.4 9436.9 9637.0 9779.6 09:32:07 INFO - PROCESS | 1664 | -------- Summary: end -------- 09:32:07 INFO - PROCESS | 1664 | 09:32:07 INFO - TEST-INFO | 1664: exit 0 09:32:07 INFO - TEST-OK | dromaeo_css | took 1110497ms 09:32:07 INFO - TEST-START | kraken 09:32:07 INFO - operating with platform_type : mac_ 09:32:07 INFO - Initialising browser for kraken test... 09:32:07 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpDHa5vd/profile http://localhost:49270/getInfo.html) 09:32:09 INFO - PROCESS | 1676 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.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] 09:32:10 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 09:32:10 INFO - PROCESS | 1676 | colorDepth:24 09:32:10 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 09:32:10 INFO - PROCESS | 1676 | __metrics 09:32:10 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 09:32:10 INFO - TEST-INFO | 1676: exit 0 09:32:10 INFO - Browser initialized. 09:32:10 INFO - Running cycle 1/1 for kraken test... 09:32:10 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpDHa5vd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:23 INFO - PROCESS | 1679 | RSS: Main: 255811584 09:32:23 INFO - PROCESS | 1679 | 09:32:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 09:32:26 INFO - PROCESS | 1679 | RSS: Main: 269004800 09:32:26 INFO - PROCESS | 1679 | 09:32:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 09:32:29 INFO - PROCESS | 1679 | RSS: Main: 276922368 09:32:29 INFO - PROCESS | 1679 | 09:32:33 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 09:32:33 INFO - PROCESS | 1679 | RSS: Main: 281927680 09:32:33 INFO - PROCESS | 1679 | 09:32:35 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 09:32:36 INFO - PROCESS | 1679 | RSS: Main: 284090368 09:32:36 INFO - PROCESS | 1679 | 09:32:38 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:32:39 INFO - PROCESS | 1679 | RSS: Main: 284884992 09:32:39 INFO - PROCESS | 1679 | 09:32:42 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 09:32:42 INFO - PROCESS | 1679 | RSS: Main: 283312128 09:32:42 INFO - PROCESS | 1679 | 09:32:45 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 09:32:46 INFO - PROCESS | 1679 | RSS: Main: 283279360 09:32:46 INFO - PROCESS | 1679 | 09:32:49 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 09:32:49 INFO - PROCESS | 1679 | RSS: Main: 283766784 09:32:49 INFO - PROCESS | 1679 | 09:32:51 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:32:51 INFO - PROCESS | 1679 | RSS: Main: 283500544 09:32:51 INFO - PROCESS | 1679 | 09:32:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:32:54 INFO - PROCESS | 1679 | RSS: Main: 284880896 09:32:54 INFO - PROCESS | 1679 | 09:32:56 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:32:57 INFO - PROCESS | 1679 | RSS: Main: 284803072 09:32:57 INFO - PROCESS | 1679 | 09:32:59 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:33:00 INFO - PROCESS | 1679 | RSS: Main: 284958720 09:33:00 INFO - PROCESS | 1679 | 09:33:02 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:33:03 INFO - PROCESS | 1679 | RSS: Main: 284934144 09:33:03 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 09:33:05 INFO - PROCESS | 1679 | RSS: Main: 286076928 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | __start_tp_report 09:33:05 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 09:33:05 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 09:33:05 INFO - PROCESS | 1679 | |i|pagename|runs| 09:33:05 INFO - PROCESS | 1679 | |0;ai-astar;113;109;114;114;133;181;164;154;116;113 09:33:05 INFO - PROCESS | 1679 | |1;audio-beat-detection;188;150;144;157;156;140;166;149;187;123 09:33:05 INFO - PROCESS | 1679 | |2;audio-dft;195;195;197;210;261;282;190;275;284;163 09:33:05 INFO - PROCESS | 1679 | |3;audio-fft;74;81;71;113;63;105;84;78;112;57 09:33:05 INFO - PROCESS | 1679 | |4;audio-oscillator;82;81;123;79;81;89;121;81;77;127 09:33:05 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;127;130;106;85;88;85;78;127;131;87 09:33:05 INFO - PROCESS | 1679 | |6;imaging-darkroom;94;95;94;95;95;94;94;95;136;93 09:33:05 INFO - PROCESS | 1679 | |7;imaging-desaturate;104;106;97;102;104;116;76;129;122;142 09:33:05 INFO - PROCESS | 1679 | |8;json-parse-financial;55;57;71;74;70;56;55;63;59;53 09:33:05 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;67;69;68;66;82;73;68;66;68;83 09:33:05 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;84;83;86;85;84;85;85;88;86;84 09:33:05 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;115;131;128;109;142;143;111;139;144;139 09:33:05 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;147;140;155;119;166;182;145;143;144;131 09:33:05 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;68;68;67;71;67;68;66;71;69;65 09:33:05 INFO - PROCESS | 1679 | __end_tp_report 09:33:05 INFO - PROCESS | 1679 | __start_cc_report 09:33:05 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,927 09:33:05 INFO - PROCESS | 1679 | __end_cc_report 09:33:05 INFO - PROCESS | 1679 | __startTimestamp1458318785507__endTimestamp 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | ------- Summary: start ------- 09:33:05 INFO - PROCESS | 1679 | Number of tests: 14 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:131.10 Median:124.50 stddev:25.94 (20.8%) stddev-sans-first:26.68 09:33:05 INFO - PROCESS | 1679 | Values: 113.0 109.0 114.0 114.0 133.0 181.0 164.0 154.0 116.0 113.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:156.50 stddev:20.17 (12.9%) stddev-sans-first:17.76 09:33:05 INFO - PROCESS | 1679 | Values: 188.0 150.0 144.0 157.0 156.0 140.0 166.0 149.0 187.0 123.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:225.20 Median:235.50 stddev:45.22 (19.2%) stddev-sans-first:46.62 09:33:05 INFO - PROCESS | 1679 | Values: 195.0 195.0 197.0 210.0 261.0 282.0 190.0 275.0 284.0 163.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:83.80 Median:72.50 stddev:19.86 (27.4%) stddev-sans-first:20.75 09:33:05 INFO - PROCESS | 1679 | Values: 74.0 81.0 71.0 113.0 63.0 105.0 84.0 78.0 112.0 57.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:81.00 stddev:20.68 (25.5%) stddev-sans-first:21.47 09:33:05 INFO - PROCESS | 1679 | Values: 82.0 81.0 123.0 79.0 81.0 89.0 121.0 81.0 77.0 127.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:104.40 Median:81.50 stddev:22.13 (27.2%) stddev-sans-first:21.91 09:33:05 INFO - PROCESS | 1679 | Values: 127.0 130.0 106.0 85.0 88.0 85.0 78.0 127.0 131.0 87.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:98.50 Median:94.50 stddev:13.19 (14.0%) stddev-sans-first:13.89 09:33:05 INFO - PROCESS | 1679 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 136.0 93.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:109.80 Median:125.50 stddev:18.38 (14.6%) stddev-sans-first:19.38 09:33:05 INFO - PROCESS | 1679 | Values: 104.0 106.0 97.0 102.0 104.0 116.0 76.0 129.0 122.0 142.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.00 stddev:7.70 (12.6%) stddev-sans-first:7.83 09:33:05 INFO - PROCESS | 1679 | Values: 55.0 57.0 71.0 74.0 70.0 56.0 55.0 63.0 59.0 53.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:68.50 stddev:6.38 (9.3%) stddev-sans-first:6.60 09:33:05 INFO - PROCESS | 1679 | Values: 67.0 69.0 68.0 66.0 82.0 73.0 68.0 66.0 68.0 83.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:1.41 (1.7%) stddev-sans-first:1.45 09:33:05 INFO - PROCESS | 1679 | Values: 84.0 83.0 86.0 85.0 84.0 85.0 85.0 88.0 86.0 84.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:139.00 stddev:13.76 (9.9%) stddev-sans-first:13.46 09:33:05 INFO - PROCESS | 1679 | Values: 115.0 131.0 128.0 109.0 142.0 143.0 111.0 139.0 144.0 139.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:146.00 stddev:17.54 (12.0%) stddev-sans-first:18.60 09:33:05 INFO - PROCESS | 1679 | Values: 147.0 140.0 155.0 119.0 166.0 182.0 145.0 143.0 144.0 131.0 09:33:05 INFO - PROCESS | 1679 | 09:33:05 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.94 (2.9%) stddev-sans-first:2.06 09:33:05 INFO - PROCESS | 1679 | Values: 68.0 68.0 67.0 71.0 67.0 68.0 66.0 71.0 69.0 65.0 09:33:05 INFO - PROCESS | 1679 | -------- Summary: end -------- 09:33:05 INFO - PROCESS | 1679 | 09:33:06 INFO - TEST-INFO | 1679: exit 0 09:33:06 INFO - TEST-OK | kraken | took 58666ms 09:33:06 INFO - SUITE-END | took 1169s 09:33:06 INFO - Completed test suite (00:19:29) 09:33:06 INFO - javascript benchmark 09:33:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3548.7870727756335, 3550.343186510495, 3551.4850346699727, 3574.499570060192, 3638.3087213429462, 5891.764329426828, 5949.524038076955, 5950.137230101638, 5986.790462333819, 5998.400159983999, 5818.883622327551, 5914.585978981473, 5940.108983652454, 5978.671173085479, 6047.516198704104, 5272.077386457364, 5326.280952071479, 5332.413434522219, 5342.732863356836, 5437.34751829781, 218.11612130070748, 4624.820670728976, 5246.081935661263, 5253.7373131343475, 5298.417174110845, 5259.237410575464, 5328.147496400596, 5352.197170424468, 5353.491418315273, 5372.409035006146, 4163.292240319153, 5339.145736682112, 5367.221752845854, 5384.67691938481, 5409.891802163935, 4893.951060489385, 5213.374395072616, 5259.5529380002745, 5283.841484755463, 5307.310049693554, 4681.5318468153255, 5687.772489100431, 5719.971400143014, 5793.102069179284, 5812.447817457335, 6159.599626024294, 6171.598846075036, 6190.84522886927, 6217.595856269373, 6229.190205273286, 6197.535184861108, 6218.4714299284615, 6243.719032643542, 6250.187475628185, 6252.187215661935, 6037.094435834616, 6057.20361087237, 6062.272527296753, 6067.666278354689, 6106.2061931948565, 6170.629762214192, 6342.904856427065, 6406.711697973602, 6470.0618410330235, 6479.708413121421, 5317.361916570037, 6111.43980788641, 6117.766507567544, 6122.142899994004, 6126.489111843539, 6154.846128846814, 6206.193194884636, 6211.254649442006, 6236.501079913596, 6247.562670613013, 6112.266528016667, 6131.009681329197, 6131.162586540493, 6160.8767824643255, 6212.4408803207925, 6211.254649442096, 6214.161088253028, 6216.906746398808, 6220.7869465454705, 6254.155688981929, 5004.524570165829, 5014.047331007097, 5015.548600625962, 5026.924596131061, 5056.241563765465, 4434.162136232813, 4463.955360446419, 4513.277875539898, 4554.544545545486, 4581.679282450196, 4981.825636102792, 5855.590108692436, 5856.472917437451, 5946.970265148733, 5948.821535353946, 6182.0, 6196.380361963767, 6216.409441103088, 6234.0, 6235.657038862815, 5859.882802344015, 5955.553333500005, 5996.730147143389, 6005.309389420273, 6024.277086749618, 5514.696691681996, 5519.558435325164, 5531.446855314517, 5535.8339249821765, 5581.190727344512, 6550.0829883816305, 6564.179477565304, 6576.375244351779, 6603.6037837730855, 6641.535092543476, 6124.167343420691, 6127.172831667668, 6164.969175154096, 6200.946617937861, 6269.279032911274, 6470.38531339522, 6540.705668244846, 6547.247066587213, 6548.901766473602, 6561.40947314744, 6126.938730612636, 6159.6612186330185, 6167.1366008759705, 6173.043178307369, 6178.691065446799, 5358.22305765654, 6078.939210608014, 6097.101247990999, 6126.975740326223, 6211.9689401552705, 6188.0, 6204.317525072329, 6238.844028899314, 6253.843653908689, 6263.530235232467, 6205.906911396423, 6206.862306966511, 6208.751649933952, 6254.874902502015, 6271.184745983175, 5107.310513080686, 5991.520678345809, 6086.543509236736, 6145.0782382642965, 6146.508279337731, 6199.721012554536, 6227.128202051807, 6240.375962403723, 6244.313125556276, 6276.811695649138, 6016.187814645142, 6169.629822210682, 6211.13044173807, 6220.160278362363, 6225.159603453657], "unit": "score", "name": "dojo.html", "value": 5732.935192414436}, {"lowerIsBetter": false, "replicates": [474.8599163246842, 565.2877374508118, 575.8712922671566, 640.2541039688762, 649.6459429610861, 34730.13174670628, 36529.26941461173, 37154.62845371546, 38990.02524936878, 39033.02417439562, 40209.19581608373, 40784.79607601965, 40807.59192408075, 40808.18383632325, 40844.77465676027, 8435.114312997139, 9391.577379017943, 9505.382150160218, 9616.90383096167, 9618.903810961905, 9357.39176953496, 9543.713688589354, 9582.952085239598, 9594.472304023277, 9615.471149086798, 9535.47554884481, 9579.425234485918, 9652.95173524135, 9659.082387173208, 9672.371295865782, 9566.904330956671, 9600.423974561549, 9603.18372938301, 9613.327067105305, 9627.13355797978, 9472.242220622335, 9607.615695372177, 9607.855882161773, 9609.855852162224, 9639.421634701941, 32904.01287961365, 39337.80331098326, 39383.8030809847, 39593.01017474557, 39626.009349766486, 3097.566340712302, 3184.7770656054086, 3224.3873664003763, 3451.0, 3492.7205823534055, 28155.0, 28719.28201794951, 29264.707352926413, 29265.85367073151, 30181.09456716302, 2608.7738762781464, 2776.7917406194615, 2784.3874347643687, 2818.2672505148603, 2889.3495724281, 501175.0, 505762.0, 506062.4696876492, 507943.92056079337, 509154.0, 46200.07599848051, 47101.5289847104, 71564.0, 73025.6348718253, 73238.0, 45511.317330240076, 45661.543384566394, 45814.77092614515, 45848.54151458442, 45874.77062614666, 15386.846131538765, 15676.372945082298, 15724.820638452162, 15808.762868556982, 15832.0, 12544.498220071095, 12635.620931372074, 12714.237145771283, 12720.809187862189, 12756.234625922474, 14657.633559160893, 14721.55835324942, 14729.705405892037, 15148.0, 15279.159646219343, 6326.5255105867245, 6441.774537891151, 6492.123563318892, 6512.023196520559, 6518.869622607616, 962.2302158273493, 979.7599588100961, 981.6564202529057, 1109.955601775936, 1150.4362862197631, 29413.411731765675, 29858.850705746332, 30319.93880214226, 30663.84668076645, 31208.843955780078, 1032.6127702111708, 1072.5816931396762, 1083.34999000599, 1110.9055730262858, 1124.814405623063, 12457.0, 13520.797188042186, 13942.581722548137, 14108.858911410754, 15452.690946181014, 529449.0, 529929.0, 530153.0, 533376.0, 534139.0, 61661.383386165566, 61954.380456195766, 62017.379826202065, 62041.0, 62132.68933655303, 1232.186756740547, 1443.2134486704772, 1473.3811799044427, 1484.6733718581895, 1492.9328180231917, 29554.556681649363, 29729.851350743975, 29914.102576922727, 30296.242593935327, 30307.242318942204, 54084.377468676, 54639.45360546344, 54951.72524137354, 55068.0, 55218.89562208814, 493396.0, 493936.0, 495619.0, 496068.0, 497108.0, 34156.82921585376, 34374.0, 34531.48202777011, 45444.545554544035, 46262.768686156356, 44103.77948110367, 44154.337684935395, 44697.0, 45221.32168017548, 47255.29117063316, 36530.90407287786, 38851.0, 39028.219435611696, 39364.2127157461, 39729.80135099306, 37796.24407511889, 37875.81062094672, 37947.051323717125, 38203.23593528058, 38974.80512597419, 38188.0, 38754.8373548794, 39536.40695389514, 40227.59772402356, 40362.9909252271, 29110.854445727637, 31440.838741887168, 31700.685023773804, 31813.68186318107, 31862.044138675876, 20216.898915505328, 24115.517689646458, 24137.396565086012, 24389.3902652428, 24607.50784984326], "unit": "score", "name": "ext.html", "value": 19475.142378214958}, {"lowerIsBetter": false, "replicates": [351.8997085830539, 361.2558130251681, 366.44849501500255, 366.9779813211209, 369.2633196772438, 19441.027948602565, 19635.509112272182, 20483.283085092007, 20717.0, 20769.584608307825, 20467.795322046775, 20576.279830205945, 20873.895630521863, 21015.894920525414, 21086.578268434623, 5740.770369185238, 5963.582549221556, 6000.0, 6004.729787159588, 6037.547183961198, 4337.1325734853, 4429.60133587977, 5824.359320474744, 6514.739410423601, 6525.575837570566, 6351.269603995554, 6429.260635026962, 6440.967795161017, 6444.838879028039, 6462.0, 6286.559940804145, 6395.52033597482, 6463.062855885917, 6467.773627923048, 6473.28793832678, 5475.233467314579, 5497.0, 5577.832665020056, 5581.0, 5589.608727389084, 24201.0, 24740.010399584175, 24914.750852491423, 25158.622620660706, 25406.745932540623, 2143.753468351144, 2195.560887822426, 2216.390492614528, 2446.645236440724, 2743.986280068607, 13735.733603955336, 14233.572992810232, 14305.14169149844, 14351.928240358731, 14661.6334591635, 1713.4773893962335, 1725.1460527039071, 1729.9827001730073, 1757.0863151161452, 1758.7098128808732, 93816.0, 95376.0462395381, 95645.0, 95957.52021239919, 96060.51969740176, 9302.0, 10250.487475626189, 10335.0, 10381.480925953672, 10725.302855314536, 11491.425428728697, 11764.176507644383, 12741.10812243134, 12786.936065319614, 12789.424475898606, 8497.660093596187, 8604.0, 8629.0, 8691.521966291915, 8794.42836215644, 8821.0, 8858.42420242695, 8961.283097352196, 8979.775505612412, 9053.68312109073, 6060.151578778975, 6132.41742034506, 6189.288231853395, 6191.318954914956, 6199.535034872402, 1788.1685016467404, 1814.2108182940462, 1821.417146513103, 1822.3986084592052, 1837.109002133964, 960.6349587156835, 966.6713317472094, 989.5497548615363, 992.6525715999487, 1060.4644654449608, 20228.221431372338, 20570.38288851337, 20638.07128679183, 20704.689429658567, 20905.0, 892.2549671024767, 941.6139382852997, 961.5240455974338, 1034.1881622925966, 1097.226455348977, 9390.0, 11329.433528323716, 11377.2604780689, 11378.715532111764, 11389.974902258837, 647491.0, 649393.0, 649876.0, 652086.0, 653812.0, 95722.0, 97719.0, 99358.00641993633, 101227.49386253022, 101520.49239753754, 1064.8243039898484, 1069.0912724184536, 1088.1892989722548, 1089.2048804372694, 1093.2893619147458, 17382.91308543449, 18063.0, 18503.629927401107, 18540.907295463436, 18778.624427511648, 44981.775091124335, 46059.848503787674, 46776.298355525374, 46911.76544117394, 47995.52004479911, 49241.75379123082, 60872.39127608667, 63124.0, 64431.35568644441, 65176.044718658515, 7729.845403092019, 7840.372770178258, 7896.84206315882, 8001.959990200012, 8081.595920203848, 11806.704832379259, 12068.75862482763, 12337.198082124632, 12545.811812822998, 12724.0, 10059.36082185754, 10649.467526623483, 10876.728081798019, 10928.950856596304, 11047.392393418118, 7027.508074434945, 7579.583122928292, 7827.491213071132, 8001.799955001172, 8011.39914506426, 4053.8175782090466, 7498.250174982458, 7938.3252423544645, 8083.474574152661, 8196.0, 10797.946010269898, 10905.83641245366, 10941.343519388862, 11000.339639981325, 11054.336739795637, 11456.541738330374, 11579.015783658484, 11786.46960886745, 11910.987566056981, 12007.39963001829], "unit": "score", "name": "jquery.html", "value": 9383.439467435355}, {"lowerIsBetter": false, "replicates": [1605.9277332520035, 1626.9999999999995, 1937.3509874192146, 2007.769106552746, 2009.4273132157339, 8082.353411727063, 8717.520536370514, 8789.956050219747, 9005.27957763379, 9057.954710226448, 8781.692640757576, 8812.986506551748, 8891.0, 8918.019017908042, 8930.151635594624, 2467.777899988996, 2477.702675678921, 2482.156066937241, 2485.490474452733, 2501.024600405843, 2408.9759102409016, 2456.631505274205, 2483.292261705414, 2495.089292408276, 2499.0378704198924, 2110.841686873483, 2148.258850696507, 2442.4016116051594, 2463.19946017545, 2487.6890388701413, 2439.256026911791, 2464.088287333698, 2479.3677612208953, 2482.342179322472, 2500.0749722602573, 2502.2618327593223, 2508.172303139978, 2517.5342561626157, 2518.659980902573, 2519.6976362836576, 8929.062448442884, 9018.278537717033, 9036.819263614756, 9102.77243068922, 9106.77233069172, 5512.145617429305, 5524.530414914737, 5669.914951275734, 5732.5987180897355, 5733.140028995643, 3625.1299688074937, 3702.777833329982, 3724.0131365188245, 3734.9439758403646, 3771.830267637963, 1060.1624716473975, 1077.175960390302, 1078.5254488025323, 1092.7104317355906, 1095.8684957805035, 12154.878451215463, 12203.084768642388, 12281.447334869952, 12289.446974886152, 12291.69270768229, 3961.870866803005, 4124.670026397881, 4864.0, 4926.729029903318, 4931.50684931504, 10387.324823886423, 10402.375857448576, 10405.0, 10405.9479702601, 10411.583536658449, 5529.225908372831, 5548.722563871871, 5581.581381396411, 5593.0, 5600.355959064678, 4483.3723278741, 4829.517048295213, 4879.658423910292, 4918.065567542156, 5016.247562865599, 3918.294706952776, 4000.419939108871, 4009.919801603952, 4051.0, 4099.692523060782, 1253.2042153232762, 1326.5688651188402, 1327.1904138475522, 1330.2151730479063, 1335.5726167626267, 1344.6974430753003, 1352.2427440633278, 1363.0935427940508, 1370.1778932640536, 1372.0875617714307, 8426.452280601741, 8432.957835210786, 8451.112633173429, 8471.872921906177, 8573.0, 471.3824889394904, 515.8942416804546, 531.3597115475842, 531.3676724697598, 532.9147336426154, 6158.876822463526, 6256.343083976208, 6282.089097080898, 6362.713677884506, 6376.872462550723, 10786.838197427045, 10962.342259464458, 10967.287126336763, 11036.724081898017, 11166.553337866557, 10602.416867072385, 10731.731706707238, 10768.676939691823, 10854.371844223271, 10902.236843421044, 8370.372222083368, 8476.703315383931, 8483.490990540464, 8529.360297977677, 8588.828223435496, 6265.310815810166, 6547.508936829661, 7192.784216473514, 8080.0, 8141.348692104499, 7783.688652453839, 9605.231581473325, 9628.277879158952, 9733.172680322252, 9829.0, 9792.951035244778, 10071.244656650633, 10152.137068349273, 10192.847107293248, 10202.540885660015, 7569.886451703339, 7575.0909890813455, 7600.581967991813, 7676.3091321779075, 7729.768106956801, 8406.117357677356, 8418.494890306602, 8421.4947103174, 8431.325493960347, 8481.660733570588, 6673.0, 7608.16310205888, 7703.730369437043, 7718.228177182237, 7756.3019328260725, 6279.874402511833, 6790.456763458813, 7490.838919967414, 7538.3969282458365, 7632.084149902047, 7408.666610002455, 7505.924940750522, 7539.132999705104, 7558.01745773046, 7565.848683026419, 7126.429885609243, 7174.42604591621, 7214.350708436266, 7237.710491580277, 7257.818554536178, 7267.818304542428, 7301.123865136217, 7307.3058059484265, 7345.0, 7353.080864891888], "unit": "score", "name": "mootools.html", "value": 4907.842815593129}, {"lowerIsBetter": false, "replicates": [326.572190430536, 329.78069583726824, 334.6603197754278, 338.5480383687777, 339.451785366633, 5503.394626591077, 6770.255271920091, 6823.078884350612, 6837.974303854418, 6898.620575868325, 5795.739191736371, 6529.8367540811505, 6739.730410783575, 6778.152730908637, 6786.219584747755, 4131.814068366915, 4750.5724484796365, 4854.781534830923, 4957.677750946195, 5059.974700126494, 4944.110060189165, 4951.084049450863, 4966.1309270877455, 4975.601951843862, 4996.325496058022, 4893.363862697862, 4895.853124406256, 4895.926561101586, 4929.876753081184, 4937.728424936627, 4903.877403064934, 4907.852764417074, 4926.778294976717, 4929.8028078876805, 4934.827281045146, 4256.127493863751, 4263.680223983182, 4263.893402664927, 4276.48682158143, 4292.420523229355, 6177.722002509898, 6393.168888044571, 6418.711157997901, 6433.163688720483, 6445.774397896051, 5864.413558644144, 5898.439648233454, 5935.851603709899, 5941.19793827832, 5974.462298393166, 7184.497085204038, 7221.133463984303, 7231.0, 7232.37271613888, 7293.671784769698, 4794.328793968847, 4803.0874133914795, 4835.685680430761, 4842.273658951185, 4843.9031219375765, 6927.134108236471, 7027.262137475594, 7701.3068823806125, 7744.690212391498, 7768.7669369918995, 4724.456687480915, 4881.048195601824, 4912.778924948386, 4921.975390123026, 4931.334269873593, 4675.602573781199, 4960.652754307164, 5011.84964451067, 5019.247112933089, 5027.4721154279005, 5915.112733090071, 5928.644281343133, 5929.080992446092, 5950.523958083343, 5966.343702192756, 7308.269173082649, 7312.817179570447, 7317.26827317264, 7340.0457940467395, 7374.0, 1724.5860993361753, 1745.746866704346, 1751.0281793604418, 1751.7897852257556, 1753.7457068724964, 1101.9008289254007, 1144.376314908377, 1147.0, 1149.6608500492375, 1160.3096157786272, 5141.922871156936, 5520.254765606592, 6406.519511036691, 6597.274299827015, 6809.965950170316, 6152.753889844445, 7484.663190156456, 7510.849783004419, 7522.172561018284, 7531.435142364345, 6566.179227596551, 6673.399394054559, 6883.105196324445, 6907.274736152732, 6932.584044957319, 3966.504186976628, 4033.979830100831, 4035.8991025224605, 4048.291548978917, 4060.127072679388, 7968.0039995000625, 7984.08183058944, 8000.119986801447, 8006.159353267823, 8021.598920053974, 7486.737964171228, 7845.37237021037, 7848.489848159851, 7879.212078792075, 7885.250901164381, 6620.304867988792, 7901.446898717149, 7930.722424715107, 7979.5611241382285, 7992.320652744465, 6162.537809664383, 7570.205128461433, 7586.468947173645, 7668.309852113337, 7675.462717609714, 7445.9255407445235, 7465.589392583242, 7484.513506622052, 7491.0, 7493.737719179802, 7682.7311044113185, 7945.364370850433, 7950.403719720928, 7990.600469976362, 7997.7600671979935, 4293.935590966075, 4401.185780630593, 4680.4149481314835, 4725.173094708343, 4747.881302967454, 7570.772876813704, 7579.54522728638, 7585.279398457138, 7591.0, 7592.696292148252, 6165.907511387243, 7102.899050647158, 7318.96340518294, 7336.7065317386705, 7349.70601175947, 7030.367266945795, 7294.525855819355, 7315.743948961974, 7338.633068346455, 7349.978755842186, 7116.181639111568, 7163.098944927313, 7172.820679483055, 7179.0, 7188.640567971476, 7283.672234749555, 7296.233895441114, 7300.379467745089, 7305.232950540117, 7363.668634911334, 7166.104236970379, 7168.0, 7169.964150179424, 7174.210836808052, 7177.031100801325], "unit": "score", "name": "prototype.html", "value": 5301.012582419621}, {"lowerIsBetter": false, "replicates": [611.5932904618429, 650.9519673325948, 682.7644462660382, 691.8028361916853, 703.4969996452536, 13481.932590337046, 13529.188248705072, 14722.411103555858, 14845.0, 15074.49255074492, 13079.476820927175, 13243.602691919234, 14313.42746290147, 14335.068220565656, 14398.0, 753.9547627142362, 909.9226565741903, 918.3250311021394, 933.7012156110047, 948.7485816258697, 925.0980294213122, 932.0493097041015, 935.7613808478862, 937.704623043739, 938.5025936253762, 978.5303054533828, 990.2869933647798, 992.846108853129, 992.9652462163825, 993.6273897288517, 965.5461932891529, 977.6480467031898, 983.1692220074026, 983.6704703924194, 986.9062439068313, 733.3546479098412, 736.1056316575333, 737.6717360774458, 745.1505283976271, 746.1009483572283, 15172.165530895796, 15249.61875953099, 15288.464903728316, 15362.615934601612, 15365.46220882275, 12957.09300348976, 12965.22208667483, 12983.026273029465, 13045.54340598084, 13238.602841914759, 10084.394936303772, 10133.949330253376, 10184.236182286359, 10291.691249262534, 10961.287516311493, 3512.7892326460496, 3566.5185199997927, 3578.0, 3580.4092324766384, 3671.614480479538, 58624.0, 84055.57972210161, 85302.19024812164, 85959.0, 86112.0, 9403.858942115874, 9437.952810235905, 9476.810463790824, 9647.71056868295, 9755.317127801127, 20831.958402079836, 20938.790612093988, 20945.162193512395, 20946.685799713017, 20977.58044839125, 7285.635718214068, 7419.666115024729, 7443.925560744432, 7472.589007604634, 7507.951440218582, 3946.743461674982, 3962.643362097425, 4041.413994970713, 4055.371417430303, 4061.5532291447917, 3093.180307218589, 3557.288542291552, 3590.9102272442874, 3606.1165014571598, 3611.0, 641.4804008752925, 641.8427485266046, 653.5229282623711, 655.0861548140317, 655.4625207330039, 543.1418358992782, 545.7298637174545, 548.5392270492805, 566.7619599768108, 604.4137186928672, 7774.455788094892, 7804.180561041009, 8703.0, 8823.382363234641, 8849.0, 506.5618240222255, 605.6638565596137, 608.6287364707525, 614.3426533608996, 634.1819053421127, 3238.481842905124, 3787.5833658297565, 3825.1775868187915, 3920.0787814863484, 3976.522817261889, 88488.67266991, 88745.66881496782, 89950.55024724966, 89990.55004724934, 90861.54569227112, 74370.25629743742, 74495.62752186204, 75066.0, 75657.0, 75983.0, 65051.67474162599, 65462.67268663626, 66153.00770488447, 66258.33741662522, 67934.66032669805, 7259.201487836228, 7520.924790752022, 7746.845063098819, 7874.0157480314965, 8544.615492302737, 48278.517214828804, 49902.750486247336, 51130.48869511406, 52831.20753188782, 53215.20177197268, 65932.0, 66079.33920660731, 66479.66760166168, 67661.0, 70594.64702676453, 10989.780204396027, 11065.0, 11126.666200014013, 11223.663290100983, 11826.58606948787, 11590.478428470571, 11678.124140689652, 11842.585509507126, 11881.821772673244, 11960.521579137085, 11402.429878505876, 11496.367699776592, 11526.423678816192, 11821.172517924007, 11863.5201984725, 11502.884971150515, 11633.069354451793, 11736.471858766205, 11747.295162289947, 12042.157049006486, 11103.333799971704, 11276.154288428237, 11371.772564548828, 12149.331786751813, 12162.0, 8844.292456603327, 9112.95443522778, 9119.042500537347, 9303.813923721624, 9493.905060949579, 8658.78353041179, 9191.448513089235, 9436.905630943602, 9636.994588027896, 9779.608815647294], "unit": "score", "name": "yui.html", "value": 6882.210842146165}], "name": "dromaeo_css", "value": 7566.094689659977}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 114.0, 114.0, 133.0, 181.0, 164.0, 154.0, 116.0, 113.0], "unit": "score", "name": "ai-astar", "value": 131.1}, {"lowerIsBetter": true, "replicates": [188.0, 150.0, 144.0, 157.0, 156.0, 140.0, 166.0, 149.0, 187.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 156.0}, {"lowerIsBetter": true, "replicates": [195.0, 195.0, 197.0, 210.0, 261.0, 282.0, 190.0, 275.0, 284.0, 163.0], "unit": "score", "name": "audio-dft", "value": 225.2}, {"lowerIsBetter": true, "replicates": [74.0, 81.0, 71.0, 113.0, 63.0, 105.0, 84.0, 78.0, 112.0, 57.0], "unit": "score", "name": "audio-fft", "value": 83.8}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 123.0, 79.0, 81.0, 89.0, 121.0, 81.0, 77.0, 127.0], "unit": "score", "name": "audio-oscillator", "value": 94.1}, {"lowerIsBetter": true, "replicates": [127.0, 130.0, 106.0, 85.0, 88.0, 85.0, 78.0, 127.0, 131.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 104.4}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 136.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 98.5}, {"lowerIsBetter": true, "replicates": [104.0, 106.0, 97.0, 102.0, 104.0, 116.0, 76.0, 129.0, 122.0, 142.0], "unit": "score", "name": "imaging-desaturate", "value": 109.8}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 71.0, 74.0, 70.0, 56.0, 55.0, 63.0, 59.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 61.3}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 66.0, 82.0, 73.0, 68.0, 66.0, 68.0, 83.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.0}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 86.0, 85.0, 84.0, 85.0, 85.0, 88.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [115.0, 131.0, 128.0, 109.0, 142.0, 143.0, 111.0, 139.0, 144.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.1}, {"lowerIsBetter": true, "replicates": [147.0, 140.0, 155.0, 119.0, 166.0, 182.0, 145.0, 143.0, 144.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 71.0, 67.0, 68.0, 66.0, 71.0, 69.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1565.4999999999998}]} 09:33:06 INFO - Return code: 0 09:33:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:33:06 ERROR - # TBPL SUCCESS # 09:33:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:33:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:33:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:33:06 INFO - 2016-03-18 09:33:06.833 screenresolution[1684:10263] starting screenresolution argv=screenresolution get 09:33:06 INFO - 2016-03-18 09:33:06.836 screenresolution[1684:10263] Display 0: 1600x1200x32@60 09:33:06 INFO - 2016-03-18 09:33:06.841 screenresolution[1685:10266] starting screenresolution argv=screenresolution list 09:33:06 INFO - Available Modes on Display 0 09:33:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:33:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:33:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:33:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:33:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:33:07 INFO - Intel Iris: 09:33:07 INFO - Chipset Model: Intel Iris 09:33:07 INFO - Type: GPU 09:33:07 INFO - Bus: Built-In 09:33:07 INFO - VRAM (Dynamic, Max): 1536 MB 09:33:07 INFO - Vendor: Intel (0x8086) 09:33:07 INFO - Device ID: 0x0a2e 09:33:07 INFO - Revision ID: 0x0009 09:33:07 INFO - Displays: 09:33:07 INFO - Display: 09:33:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:33:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:33:07 INFO - Display Serial Number: 1600x1200 60 09:33:07 INFO - Main Display: Yes 09:33:07 INFO - Mirror: Off 09:33:07 INFO - Online: Yes 09:33:07 INFO - Rotation: Supported 09:33:07 INFO - Return code: 0 09:33:07 INFO - Running post-action listener: _resource_record_post_action 09:33:07 INFO - Running post-run listener: _resource_record_post_run 09:33:08 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 39450112; Write bytes: 705803264; Read time: 431; Write time: 1884 09:33:08 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 385206784; Write bytes: 379148288; Read time: 28644; Write time: 668 09:33:08 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 38483456; Write bytes: 301837312; Read time: 415; Write time: 1164 09:33:08 INFO - Running post-run listener: _upload_blobber_files 09:33:08 INFO - Blob upload gear active. 09:33:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:33:08 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 09:33:08 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'] 09:33:08 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 09:33:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:09 INFO - (blobuploader) - INFO - Done attempting. 09:33:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:33:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:33:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:10 INFO - (blobuploader) - INFO - Done attempting. 09:33:10 INFO - (blobuploader) - INFO - Iteration through files over. 09:33:10 INFO - Return code: 0 09:33:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:33:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:33:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44eb830dbd1c5288a26c1b84fafdfc389760014195e58eeaed20372d27f7ce9cc52f9974e6dfbcb273874a38259ca36d92ff8777568799f85c40de1aa22a8c67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40bf8faef96e502f31df94b50ceea950b2e079f41df332f65621668ae5ba8dc5ea0a81e51bcdb4c632aa6f510e0e8f0606e8cb024a00acaa5317be493d90fc96"} 09:33:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:33:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:33:10 INFO - Contents: 09:33:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44eb830dbd1c5288a26c1b84fafdfc389760014195e58eeaed20372d27f7ce9cc52f9974e6dfbcb273874a38259ca36d92ff8777568799f85c40de1aa22a8c67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40bf8faef96e502f31df94b50ceea950b2e079f41df332f65621668ae5ba8dc5ea0a81e51bcdb4c632aa6f510e0e8f0606e8cb024a00acaa5317be493d90fc96"} 09:33:10 INFO - Running post-run listener: copy_logs_to_upload_dir 09:33:10 INFO - Copying logs to upload dir... 09:33:10 INFO - mkdir: /builds/slave/test/build/upload/logs 09:33:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.298781 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-18 09:33:10.420483) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:33:10.423958) ========= 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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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/44eb830dbd1c5288a26c1b84fafdfc389760014195e58eeaed20372d27f7ce9cc52f9974e6dfbcb273874a38259ca36d92ff8777568799f85c40de1aa22a8c67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40bf8faef96e502f31df94b50ceea950b2e079f41df332f65621668ae5ba8dc5ea0a81e51bcdb4c632aa6f510e0e8f0606e8cb024a00acaa5317be493d90fc96"} build_url:https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/fMbZDkD9Rr--w80yB63lLg/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/44eb830dbd1c5288a26c1b84fafdfc389760014195e58eeaed20372d27f7ce9cc52f9974e6dfbcb273874a38259ca36d92ff8777568799f85c40de1aa22a8c67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40bf8faef96e502f31df94b50ceea950b2e079f41df332f65621668ae5ba8dc5ea0a81e51bcdb4c632aa6f510e0e8f0606e8cb024a00acaa5317be493d90fc96"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 09:33:10.451851) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:33:10.452173) ========= 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.EAC4iOh9T7/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.gYgnY2HSdv/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005188 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 09:33:10.500456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:33:10.500779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 09:33:10.501158) ========= ========= Total master_lag: 0.26 =========