builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0079 starttime: 1457789404.96 results: success (0) buildid: 20160312044030 builduid: db5959ef006c47a2a1db3a933e596727 revision: 31481f9ebdda792e0ec01d8a007de8b193bc206f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:04.962512) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:04.963040) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:04.963349) ========= 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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005553 basedir: '/builds/slave/test' ========= master_lag: 0.29 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.257850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.259292) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.435390) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.435664) ========= 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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005913 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.586558) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.586834) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.587208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:05.590539) ========= 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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-12 05:30:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 44.7M=0s 2016-03-12 05:30:05 (44.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.392105 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:06.034691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:06.035174) ========= 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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.025944 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:06.117390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-12 05:30:06.117886) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 31481f9ebdda792e0ec01d8a007de8b193bc206f --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 31481f9ebdda792e0ec01d8a007de8b193bc206f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jfkpOKo9Sq/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.ut6cIODPyR/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-12 05:30:06,201 truncating revision to first 12 chars 2016-03-12 05:30:06,201 Setting DEBUG logging. 2016-03-12 05:30:06,201 attempt 1/10 2016-03-12 05:30:06,201 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/31481f9ebdda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-12 05:30:07,007 unpacking tar archive at: mozilla-central-31481f9ebdda/testing/mozharness/ program finished with exit code 0 elapsedTime=1.057375 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-12 05:30:07.198874) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:07.199241) ========= echo 31481f9ebdda792e0ec01d8a007de8b193bc206f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'31481f9ebdda792e0ec01d8a007de8b193bc206f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jfkpOKo9Sq/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.ut6cIODPyR/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 31481f9ebdda792e0ec01d8a007de8b193bc206f program finished with exit code 0 elapsedTime=0.005724 script_repo_revision: '31481f9ebdda792e0ec01d8a007de8b193bc206f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:07.249856) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:07.250191) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 05:30:07.264237) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 35 secs) (at 2016-03-12 05:30:07.264603) ========= /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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:30:07 INFO - MultiFileLogger online at 20160312 05:30:07 in /builds/slave/test 05:30:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:30:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:30:07 INFO - {'append_to_log': False, 05:30:07 INFO - 'base_work_dir': '/builds/slave/test', 05:30:07 INFO - 'blob_upload_branch': 'Firefox', 05:30:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:30:07 INFO - 'branch': 'Firefox', 05:30:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:30:07 INFO - 'config_files': ('talos/mac_config.py',), 05:30:07 INFO - 'default_actions': ('clobber', 05:30:07 INFO - 'read-buildbot-config', 05:30:07 INFO - 'download-and-extract', 05:30:07 INFO - 'populate-webroot', 05:30:07 INFO - 'create-virtualenv', 05:30:07 INFO - 'install', 05:30:07 INFO - 'run-tests'), 05:30:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:30:07 INFO - 'download_minidump_stackwalk': True, 05:30:07 INFO - 'download_symbols': 'ondemand', 05:30:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:30:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:30:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:30:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:30:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:30:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:30:07 INFO - 'installer_path': 'installer.exe', 05:30:07 INFO - 'log_level': 'info', 05:30:07 INFO - 'log_name': 'talos', 05:30:07 INFO - 'log_to_console': True, 05:30:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:30:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:30:07 INFO - 'opt_config_files': (), 05:30:07 INFO - 'pip_index': False, 05:30:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:30:07 INFO - 'cmd': ('bash', 05:30:07 INFO - '-c', 05:30:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:30:07 INFO - 'enabled': True, 05:30:07 INFO - 'halt_on_failure': False, 05:30:07 INFO - 'name': 'check_screen_resolution'},), 05:30:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:30:07 INFO - 'cmd': ('bash', 05:30:07 INFO - '-c', 05:30:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:30:07 INFO - 'enabled': True, 05:30:07 INFO - 'halt_on_failure': False, 05:30:07 INFO - 'name': 'check_screen_resolution'},), 05:30:07 INFO - 'run_cmd_checks_enabled': True, 05:30:07 INFO - 'sps_profile': False, 05:30:07 INFO - 'sps_profile_interval': 0, 05:30:07 INFO - 'suite': 'dromaeojs-e10s', 05:30:07 INFO - 'system_bits': '32', 05:30:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:30:07 INFO - 'title': 't-yosemite-r7-0079', 05:30:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:30:07 INFO - 'use_talos_json': True, 05:30:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:30:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:30:07 INFO - 'work_dir': 'build'} 05:30:07 INFO - ##### 05:30:07 INFO - ##### Running clobber step. 05:30:07 INFO - ##### 05:30:07 INFO - Running pre-action listener: _resource_record_pre_action 05:30:07 INFO - Running main action method: clobber 05:30:07 INFO - rmtree: /builds/slave/test/build 05:30:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:30:09 INFO - Running post-action listener: _resource_record_post_action 05:30:09 INFO - ##### 05:30:09 INFO - ##### Running read-buildbot-config step. 05:30:09 INFO - ##### 05:30:09 INFO - Running pre-action listener: _resource_record_pre_action 05:30:09 INFO - Running main action method: read_buildbot_config 05:30:09 INFO - Using buildbot properties: 05:30:09 INFO - { 05:30:09 INFO - "project": "", 05:30:09 INFO - "product": "firefox", 05:30:09 INFO - "script_repo_revision": "production", 05:30:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:30:09 INFO - "repository": "", 05:30:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:30:09 INFO - "buildid": "20160312044030", 05:30:09 INFO - "pgo_build": "False", 05:30:09 INFO - "basedir": "/builds/slave/test", 05:30:09 INFO - "buildnumber": 186, 05:30:09 INFO - "slavename": "t-yosemite-r7-0079", 05:30:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:30:09 INFO - "platform": "yosemite_r7", 05:30:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:30:09 INFO - "branch": "mozilla-central", 05:30:09 INFO - "repo_path": "mozilla-central", 05:30:09 INFO - "revision": "31481f9ebdda792e0ec01d8a007de8b193bc206f", 05:30:09 INFO - "stage_platform": "macosx64", 05:30:09 INFO - "builduid": "db5959ef006c47a2a1db3a933e596727", 05:30:09 INFO - "slavebuilddir": "test" 05:30:09 INFO - } 05:30:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:30:09 INFO - Running post-action listener: _resource_record_post_action 05:30:09 INFO - ##### 05:30:09 INFO - ##### Running download-and-extract step. 05:30:09 INFO - ##### 05:30:09 INFO - Running pre-action listener: _resource_record_pre_action 05:30:09 INFO - Running main action method: download_and_extract 05:30:09 INFO - mkdir: /builds/slave/test/build/tests 05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:09 INFO - https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:30:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:30:22 INFO - Downloaded 1199 bytes. 05:30:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:30:22 INFO - Using the following test package requirements: 05:30:22 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:30:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:22 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:30:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:22 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:30:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:22 INFO - u'jsshell-mac.zip'], 05:30:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:22 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:30:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:30:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:22 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:30:22 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:22 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:30:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:22 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:30:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:30:22 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:30:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:22 INFO - https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:30:24 INFO - Downloaded 17864979 bytes. 05:30:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:30:27 INFO - Return code: 0 05:30:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:27 INFO - https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:30:46 INFO - Downloaded 17864979 bytes. 05:30:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:30:49 INFO - Return code: 0 05:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:49 INFO - https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:30:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:30:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:30:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:30:50 INFO - Downloaded 10845263 bytes. 05:30:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:30:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:30:51 INFO - Return code: 0 05:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:51 INFO - https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:30:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:30:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:30:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:31:23 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg: The read operation timed out 05:31:23 INFO - retry: attempt #1 caught exception: The read operation timed out 05:31:23 INFO - retry: Failed, sleeping 30 seconds before retrying 05:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #2 05:31:57 INFO - Downloaded 111023981 bytes. 05:31:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:31:57 INFO - mkdir: /builds/slave/test/properties 05:31:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:31:57 INFO - Writing to file /builds/slave/test/properties/build_url 05:31:57 INFO - Contents: 05:31:57 INFO - build_url:https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:31:58 INFO - Running post-action listener: _resource_record_post_action 05:31:58 INFO - Running post-action listener: set_extra_try_arguments 05:31:58 INFO - ##### 05:31:58 INFO - ##### Running populate-webroot step. 05:31:58 INFO - ##### 05:31:58 INFO - Running pre-action listener: _resource_record_pre_action 05:31:58 INFO - Running main action method: populate_webroot 05:31:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:31:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:31:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:31:58 INFO - '--tppagecycles', 05:31:58 INFO - '7'], 05:31:58 INFO - 'tests': ['tsvgm']}}, 05:31:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:31:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:31:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:31:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:31:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:31:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:31:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:58 INFO - 'talos_options': ['--e10s'], 05:31:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:58 INFO - 'tests': ['damp', 'tps']}, 05:31:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:58 INFO - 'talos_options': ['--e10s'], 05:31:58 INFO - 'tests': ['damp', 'tps']}, 05:31:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:31:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:31:58 INFO - 'other': {'tests': ['a11yr', 05:31:58 INFO - 'ts_paint', 05:31:58 INFO - 'tpaint', 05:31:58 INFO - 'sessionrestore', 05:31:58 INFO - 'sessionrestore_no_auto_restore', 05:31:58 INFO - 'tabpaint']}, 05:31:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:31:58 INFO - 'tests': ['a11yr', 05:31:58 INFO - 'ts_paint', 05:31:58 INFO - 'tpaint', 05:31:58 INFO - 'sessionrestore', 05:31:58 INFO - 'sessionrestore_no_auto_restore', 05:31:58 INFO - 'tabpaint']}, 05:31:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:31:58 INFO - 'tests': ['a11yr', 05:31:58 INFO - 'ts_paint', 05:31:58 INFO - 'tpaint', 05:31:58 INFO - 'sessionrestore', 05:31:58 INFO - 'sessionrestore_no_auto_restore', 05:31:58 INFO - 'tabpaint']}, 05:31:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:31:58 INFO - 'tests': ['a11yr', 05:31:58 INFO - 'ts_paint', 05:31:58 INFO - 'tpaint', 05:31:58 INFO - 'sessionrestore', 05:31:58 INFO - 'sessionrestore_no_auto_restore', 05:31:58 INFO - 'tabpaint']}, 05:31:58 INFO - 'other_l64': {'tests': ['a11yr', 05:31:58 INFO - 'ts_paint', 05:31:58 INFO - 'tpaint', 05:31:58 INFO - 'sessionrestore', 05:31:58 INFO - 'sessionrestore_no_auto_restore', 05:31:58 INFO - 'tabpaint']}, 05:31:58 INFO - 'other_nol64': {'tests': ['a11yr', 05:31:58 INFO - 'ts_paint', 05:31:58 INFO - 'tpaint', 05:31:58 INFO - 'sessionrestore', 05:31:58 INFO - 'sessionrestore_no_auto_restore', 05:31:58 INFO - 'tabpaint']}, 05:31:58 INFO - 'svgr': {'tests': ['tsvgx', 05:31:58 INFO - 'tsvgr_opacity', 05:31:58 INFO - 'tart', 05:31:58 INFO - 'tscrollx', 05:31:58 INFO - 'cart']}, 05:31:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:31:58 INFO - 'tests': ['tsvgx', 05:31:58 INFO - 'tsvgr_opacity', 05:31:58 INFO - 'tart', 05:31:58 INFO - 'tscrollx', 05:31:58 INFO - 'cart']}, 05:31:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:58 INFO - 'tests': ['tp5o']}, 05:31:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:58 INFO - 'talos_options': ['--e10s'], 05:31:58 INFO - 'tests': ['tp5o']}, 05:31:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:58 INFO - 'talos_options': ['--xperf_path', 05:31:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:58 INFO - 'tests': ['tp5n']}, 05:31:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:58 INFO - 'talos_options': ['--e10s', 05:31:58 INFO - '--xperf_path', 05:31:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:58 INFO - 'tests': ['tp5n']}}, 05:31:58 INFO - 'talos.zip': {'path': '', 05:31:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:31:58 INFO - Running post-action listener: _resource_record_post_action 05:31:58 INFO - ##### 05:31:58 INFO - ##### Running create-virtualenv step. 05:31:58 INFO - ##### 05:31:58 INFO - Running pre-action listener: _resource_record_pre_action 05:31:58 INFO - Running main action method: create_virtualenv 05:31:58 INFO - Creating virtualenv /builds/slave/test/build/venv 05:31:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:31:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:31:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:31:58 INFO - Using real prefix '/tools/python27' 05:31:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:31:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:02 INFO - Installing pip.................done. 05:32:02 INFO - Return code: 0 05:32:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0cb5a8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b08d30>, '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 0x10092cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100affb20>, '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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:32:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfkpOKo9Sq/Render', 05:32:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:02 INFO - 'HOME': '/Users/cltbld', 05:32:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:02 INFO - 'LOGNAME': 'cltbld', 05:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:02 INFO - 'MOZ_NO_REMOTE': '1', 05:32:02 INFO - 'NO_EM_RESTART': '1', 05:32:02 INFO - 'PAGER': '/bin/cat', 05:32:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:02 INFO - 'PWD': '/builds/slave/test', 05:32:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:02 INFO - 'SHELL': '/bin/bash', 05:32:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut6cIODPyR/Listeners', 05:32:02 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:32:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:02 INFO - 'USER': 'cltbld', 05:32:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:02 INFO - 'XPC_FLAGS': '0x0', 05:32:02 INFO - 'XPC_SERVICE_NAME': '0', 05:32:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:32:02 INFO - Cleaning up... 05:32:02 INFO - Return code: 0 05:32:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100c64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0cb5a8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b08d30>, '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 0x10092cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100affb20>, '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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:32:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfkpOKo9Sq/Render', 05:32:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:02 INFO - 'HOME': '/Users/cltbld', 05:32:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:02 INFO - 'LOGNAME': 'cltbld', 05:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:02 INFO - 'MOZ_NO_REMOTE': '1', 05:32:02 INFO - 'NO_EM_RESTART': '1', 05:32:02 INFO - 'PAGER': '/bin/cat', 05:32:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:02 INFO - 'PWD': '/builds/slave/test', 05:32:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:02 INFO - 'SHELL': '/bin/bash', 05:32:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut6cIODPyR/Listeners', 05:32:02 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:32:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:02 INFO - 'USER': 'cltbld', 05:32:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:02 INFO - 'XPC_FLAGS': '0x0', 05:32:02 INFO - 'XPC_SERVICE_NAME': '0', 05:32:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:02 INFO - Downloading/unpacking psutil>=0.7.1 05:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:05 INFO - Installing collected packages: psutil 05:32:05 INFO - Running setup.py install for psutil 05:32:05 INFO - building 'psutil._psutil_osx' extension 05:32:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:32:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:32:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:32:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:32:06 INFO - building 'psutil._psutil_posix' extension 05:32:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:32:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:06 INFO - ^ 05:32:06 INFO - 1 warning generated. 05:32:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:32:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:06 INFO - Successfully installed psutil 05:32:06 INFO - Cleaning up... 05:32:06 INFO - Return code: 0 05:32:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:06 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 0x100c64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0cb5a8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b08d30>, '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 0x10092cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100affb20>, '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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfkpOKo9Sq/Render', 05:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:06 INFO - 'HOME': '/Users/cltbld', 05:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:06 INFO - 'LOGNAME': 'cltbld', 05:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:06 INFO - 'MOZ_NO_REMOTE': '1', 05:32:06 INFO - 'NO_EM_RESTART': '1', 05:32:06 INFO - 'PAGER': '/bin/cat', 05:32:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:06 INFO - 'PWD': '/builds/slave/test', 05:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:06 INFO - 'SHELL': '/bin/bash', 05:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut6cIODPyR/Listeners', 05:32:06 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:06 INFO - 'USER': 'cltbld', 05:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:06 INFO - 'XPC_FLAGS': '0x0', 05:32:06 INFO - 'XPC_SERVICE_NAME': '0', 05:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:32:09 INFO - Installing collected packages: mozsystemmonitor 05:32:09 INFO - Running setup.py install for mozsystemmonitor 05:32:09 INFO - Successfully installed mozsystemmonitor 05:32:09 INFO - Cleaning up... 05:32:09 INFO - Return code: 0 05:32:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:09 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 0x100c64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0cb5a8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b08d30>, '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 0x10092cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100affb20>, '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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:32:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfkpOKo9Sq/Render', 05:32:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:09 INFO - 'HOME': '/Users/cltbld', 05:32:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:09 INFO - 'LOGNAME': 'cltbld', 05:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:09 INFO - 'MOZ_NO_REMOTE': '1', 05:32:09 INFO - 'NO_EM_RESTART': '1', 05:32:09 INFO - 'PAGER': '/bin/cat', 05:32:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:09 INFO - 'PWD': '/builds/slave/test', 05:32:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:09 INFO - 'SHELL': '/bin/bash', 05:32:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut6cIODPyR/Listeners', 05:32:09 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:32:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:09 INFO - 'USER': 'cltbld', 05:32:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:09 INFO - 'XPC_FLAGS': '0x0', 05:32:09 INFO - 'XPC_SERVICE_NAME': '0', 05:32:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:12 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:13 INFO - Downloading docopt-0.6.1.tar.gz 05:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:13 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:13 INFO - Running setup.py install for blobuploader 05:32:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:13 INFO - Running setup.py install for requests 05:32:14 INFO - Running setup.py install for docopt 05:32:14 INFO - Successfully installed blobuploader requests docopt 05:32:14 INFO - Cleaning up... 05:32:14 INFO - Return code: 0 05:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:14 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 0x100c64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0cb5a8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b08d30>, '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 0x10092cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100affb20>, '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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfkpOKo9Sq/Render', 05:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:14 INFO - 'HOME': '/Users/cltbld', 05:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:14 INFO - 'LOGNAME': 'cltbld', 05:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:14 INFO - 'MOZ_NO_REMOTE': '1', 05:32:14 INFO - 'NO_EM_RESTART': '1', 05:32:14 INFO - 'PAGER': '/bin/cat', 05:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:14 INFO - 'PWD': '/builds/slave/test', 05:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:14 INFO - 'SHELL': '/bin/bash', 05:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut6cIODPyR/Listeners', 05:32:14 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:14 INFO - 'USER': 'cltbld', 05:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:14 INFO - 'XPC_FLAGS': '0x0', 05:32:14 INFO - 'XPC_SERVICE_NAME': '0', 05:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-tKJ1yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-4sBxJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-e2WWKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-rii49Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-DYhLS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-0X8Tw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-q90SvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-AY4dwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-0hDx98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-nQlXwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-8Vej_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-WMEG8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:15 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-US96Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:16 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-KSoe8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:16 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-KhB7ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:16 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-4onbnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:16 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-1g0pBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:16 INFO - Running setup.py install for manifestparser 05:32:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:16 INFO - Running setup.py install for mozcrash 05:32:16 INFO - Running setup.py install for mozdebug 05:32:16 INFO - Running setup.py install for mozdevice 05:32:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:17 INFO - Running setup.py install for mozfile 05:32:17 INFO - Running setup.py install for mozhttpd 05:32:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:17 INFO - Running setup.py install for mozinfo 05:32:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:17 INFO - Running setup.py install for mozInstall 05:32:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:17 INFO - Running setup.py install for mozleak 05:32:17 INFO - Running setup.py install for mozlog 05:32:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:17 INFO - Running setup.py install for moznetwork 05:32:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:18 INFO - Running setup.py install for mozprocess 05:32:18 INFO - Running setup.py install for mozprofile 05:32:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:18 INFO - Running setup.py install for mozrunner 05:32:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:18 INFO - Running setup.py install for mozscreenshot 05:32:18 INFO - Running setup.py install for moztest 05:32:18 INFO - Running setup.py install for mozversion 05:32:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:19 INFO - Cleaning up... 05:32:19 INFO - Return code: 0 05:32:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:19 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 0x100c64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0cb5a8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b08d30>, '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 0x10092cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100affb20>, '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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfkpOKo9Sq/Render', 05:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:19 INFO - 'HOME': '/Users/cltbld', 05:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:19 INFO - 'LOGNAME': 'cltbld', 05:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:19 INFO - 'MOZ_NO_REMOTE': '1', 05:32:19 INFO - 'NO_EM_RESTART': '1', 05:32:19 INFO - 'PAGER': '/bin/cat', 05:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:19 INFO - 'PWD': '/builds/slave/test', 05:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:19 INFO - 'SHELL': '/bin/bash', 05:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut6cIODPyR/Listeners', 05:32:19 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:19 INFO - 'USER': 'cltbld', 05:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:19 INFO - 'XPC_FLAGS': '0x0', 05:32:19 INFO - 'XPC_SERVICE_NAME': '0', 05:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9P0oEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-mAPyXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-97Ubow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-iud4vN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ukklrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-xUKZft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-3JuhXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:20 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-gqFSX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:20 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Pgn45z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:20 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-QwSLJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:20 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yNugUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:20 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-k4KecV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:20 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-4MXxnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:20 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Z1iMId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:20 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Fyz3aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:20 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-_q9tUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:20 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-fgZXT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:32:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:23 INFO - Downloading blessings-1.6.tar.gz 05:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:23 INFO - Installing collected packages: blessings 05:32:23 INFO - Running setup.py install for blessings 05:32:23 INFO - Successfully installed blessings 05:32:23 INFO - Cleaning up... 05:32:23 INFO - Return code: 0 05:32:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:24 INFO - Reading from file tmpfile_stdout 05:32:24 INFO - Current package versions: 05:32:24 INFO - blessings == 1.6 05:32:24 INFO - blobuploader == 1.2.4 05:32:24 INFO - docopt == 0.6.1 05:32:24 INFO - manifestparser == 1.1 05:32:24 INFO - mozInstall == 1.12 05:32:24 INFO - mozcrash == 0.17 05:32:24 INFO - mozdebug == 0.1 05:32:24 INFO - mozdevice == 0.48 05:32:24 INFO - mozfile == 1.2 05:32:24 INFO - mozhttpd == 0.7 05:32:24 INFO - mozinfo == 0.9 05:32:24 INFO - mozleak == 0.1 05:32:24 INFO - mozlog == 3.1 05:32:24 INFO - moznetwork == 0.27 05:32:24 INFO - mozprocess == 0.22 05:32:24 INFO - mozprofile == 0.28 05:32:24 INFO - mozrunner == 6.11 05:32:24 INFO - mozscreenshot == 0.1 05:32:24 INFO - mozsystemmonitor == 0.0 05:32:24 INFO - moztest == 0.7 05:32:24 INFO - mozversion == 1.4 05:32:24 INFO - psutil == 3.1.1 05:32:24 INFO - requests == 1.2.3 05:32:24 INFO - wsgiref == 0.1.2 05:32:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:24 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 0x100c64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0cb5a8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b08d30>, '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 0x10092cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100affb20>, '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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfkpOKo9Sq/Render', 05:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:24 INFO - 'HOME': '/Users/cltbld', 05:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:24 INFO - 'LOGNAME': 'cltbld', 05:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:24 INFO - 'MOZ_NO_REMOTE': '1', 05:32:24 INFO - 'NO_EM_RESTART': '1', 05:32:24 INFO - 'PAGER': '/bin/cat', 05:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:24 INFO - 'PWD': '/builds/slave/test', 05:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:24 INFO - 'SHELL': '/bin/bash', 05:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut6cIODPyR/Listeners', 05:32:24 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:24 INFO - 'USER': 'cltbld', 05:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:24 INFO - 'XPC_FLAGS': '0x0', 05:32:24 INFO - 'XPC_SERVICE_NAME': '0', 05:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:24 INFO - Cleaning up... 05:32:24 INFO - Return code: 0 05:32:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:24 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 0x100c64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0cb5a8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b08d30>, '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 0x10092cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100affb20>, '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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfkpOKo9Sq/Render', 05:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:24 INFO - 'HOME': '/Users/cltbld', 05:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:24 INFO - 'LOGNAME': 'cltbld', 05:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:24 INFO - 'MOZ_NO_REMOTE': '1', 05:32:24 INFO - 'NO_EM_RESTART': '1', 05:32:24 INFO - 'PAGER': '/bin/cat', 05:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:24 INFO - 'PWD': '/builds/slave/test', 05:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:24 INFO - 'SHELL': '/bin/bash', 05:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut6cIODPyR/Listeners', 05:32:24 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:24 INFO - 'USER': 'cltbld', 05:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:24 INFO - 'XPC_FLAGS': '0x0', 05:32:24 INFO - 'XPC_SERVICE_NAME': '0', 05:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:24 INFO - Downloading/unpacking jsonschema 05:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:26 INFO - Downloading/unpacking functools32 (from jsonschema) 05:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:27 INFO - warning: no files found matching '*.txt' 05:32:27 INFO - no previously-included directories found matching 'build' 05:32:27 INFO - no previously-included directories found matching 'dist' 05:32:27 INFO - no previously-included directories found matching '.git*' 05:32:27 INFO - Installing collected packages: jsonschema, functools32 05:32:27 INFO - Running setup.py install for functools32 05:32:27 INFO - warning: no files found matching '*.txt' 05:32:27 INFO - no previously-included directories found matching 'build' 05:32:27 INFO - no previously-included directories found matching 'dist' 05:32:27 INFO - no previously-included directories found matching '.git*' 05:32:27 INFO - Successfully installed jsonschema functools32 05:32:27 INFO - Cleaning up... 05:32:27 INFO - Return code: 0 05:32:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:27 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 0x100c64a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0cb5a8980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b08d30>, '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 0x10092cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100affb20>, '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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfkpOKo9Sq/Render', 05:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:27 INFO - 'HOME': '/Users/cltbld', 05:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:27 INFO - 'LOGNAME': 'cltbld', 05:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:27 INFO - 'MOZ_NO_REMOTE': '1', 05:32:27 INFO - 'NO_EM_RESTART': '1', 05:32:27 INFO - 'PAGER': '/bin/cat', 05:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:27 INFO - 'PWD': '/builds/slave/test', 05:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:27 INFO - 'SHELL': '/bin/bash', 05:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut6cIODPyR/Listeners', 05:32:27 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:27 INFO - 'USER': 'cltbld', 05:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:27 INFO - 'XPC_FLAGS': '0x0', 05:32:27 INFO - 'XPC_SERVICE_NAME': '0', 05:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:27 INFO - Downloading/unpacking flake8 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:32:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:32:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:32:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:32:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:32:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:32:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:32:31 INFO - no previously-included directories found matching 'docs/_build' 05:32:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:32:31 INFO - Running setup.py install for pep8 05:32:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:32:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:32:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:32:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:32:31 INFO - no previously-included directories found matching 'docs/_build' 05:32:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:32:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:32:31 INFO - Cleaning up... 05:32:31 INFO - Return code: 0 05:32:31 INFO - Running post-action listener: _resource_record_post_action 05:32:31 INFO - Running post-action listener: _start_resource_monitoring 05:32:31 INFO - Starting resource monitoring. 05:32:31 INFO - ##### 05:32:31 INFO - ##### Running install step. 05:32:31 INFO - ##### 05:32:31 INFO - Running pre-action listener: _resource_record_pre_action 05:32:31 INFO - Running main action method: install 05:32:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:32 INFO - Reading from file tmpfile_stdout 05:32:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:32 INFO - Reading from file tmpfile_stdout 05:32:32 INFO - Output received: 05:32:32 INFO - Usage: mozinstall [options] installer 05:32:32 INFO - Options: 05:32:32 INFO - -h, --help show this help message and exit 05:32:32 INFO - -d DEST, --destination=DEST 05:32:32 INFO - Directory to install application into. [default: 05:32:32 INFO - "/builds/slave/test"] 05:32:32 INFO - --app=APP Application being installed. [default: firefox] 05:32:32 INFO - mkdir: /builds/slave/test/build/application 05:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:33:06 INFO - Reading from file tmpfile_stdout 05:33:06 INFO - Output received: 05:33:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:33:06 INFO - Running post-action listener: _resource_record_post_action 05:33:06 INFO - ##### 05:33:06 INFO - ##### Running run-tests step. 05:33:06 INFO - ##### 05:33:06 INFO - Running pre-action listener: _resource_record_pre_action 05:33:06 INFO - Running main action method: run_tests 05:33:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:06 INFO - 2016-03-12 05:33:06.448 screenresolution[1652:8109] starting screenresolution argv=screenresolution get 05:33:06 INFO - 2016-03-12 05:33:06.451 screenresolution[1652:8109] Display 0: 1600x1200x32@60 05:33:06 INFO - 2016-03-12 05:33:06.456 screenresolution[1653:8111] starting screenresolution argv=screenresolution list 05:33:06 INFO - Available Modes on Display 0 05:33:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:06 INFO - Intel Iris: 05:33:06 INFO - Chipset Model: Intel Iris 05:33:06 INFO - Type: GPU 05:33:06 INFO - Bus: Built-In 05:33:06 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:06 INFO - Vendor: Intel (0x8086) 05:33:06 INFO - Device ID: 0x0a2e 05:33:06 INFO - Revision ID: 0x0009 05:33:06 INFO - Displays: 05:33:06 INFO - Display: 05:33:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:06 INFO - Display Serial Number: 1600x1200 60 05:33:06 INFO - Main Display: Yes 05:33:06 INFO - Mirror: Off 05:33:06 INFO - Online: Yes 05:33:06 INFO - Rotation: Supported 05:33:06 INFO - Return code: 0 05:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:06 INFO - Python 2.7.3 05:33:06 INFO - Return code: 0 05:33:06 INFO - grabbing minidump binary from tooltool 05:33: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')]} 05:33:06 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 0x100b08d30>, '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 0x10092cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100affb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:33:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:33:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:06 INFO - Return code: 0 05:33:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:33:07 INFO - Return code: 0 05:33:07 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/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:33:07 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/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfkpOKo9Sq/Render', 05:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:07 INFO - 'HOME': '/Users/cltbld', 05:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:07 INFO - 'LOGNAME': 'cltbld', 05:33:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:07 INFO - 'MOZ_NO_REMOTE': '1', 05:33:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:07 INFO - 'NO_EM_RESTART': '1', 05:33:07 INFO - 'PAGER': '/bin/cat', 05:33:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:07 INFO - 'PWD': '/builds/slave/test', 05:33:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:07 INFO - 'SHELL': '/bin/bash', 05:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut6cIODPyR/Listeners', 05:33:07 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 05:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:07 INFO - 'USER': 'cltbld', 05:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:07 INFO - 'XPC_FLAGS': '0x0', 05:33:07 INFO - 'XPC_SERVICE_NAME': '0', 05:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:07 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/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:33:08 INFO - mozversion application_buildid: 20160312044030 05:33:08 INFO - mozversion application_changeset: 31481f9ebdda792e0ec01d8a007de8b193bc206f 05:33:08 INFO - mozversion application_display_name: Nightly 05:33:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:08 INFO - mozversion application_name: Firefox 05:33:08 INFO - mozversion application_remotingname: firefox 05:33:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:08 INFO - mozversion application_vendor: Mozilla 05:33:08 INFO - mozversion application_version: 48.0a1 05:33:08 INFO - mozversion platform_buildid: 20160312044030 05:33:08 INFO - mozversion platform_changeset: 31481f9ebdda792e0ec01d8a007de8b193bc206f 05:33:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:08 INFO - mozversion platform_version: 48.0a1 05:33:08 INFO - using testdate: 1457789588 05:33:08 INFO - actual date: 1457789588 05:33:08 INFO - starting webserver on 'localhost:49274' 05:33:08 INFO - SUITE-START | Running 2 tests 05:33:08 INFO - TEST-START | dromaeo_css 05:33:08 INFO - operating with platform_type : mac_ 05:33:08 INFO - Initialising browser for dromaeo_css test... 05:33:08 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpa1twpn/profile http://localhost:49274/getInfo.html) 05:33:11 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 05:33:11 INFO - PROCESS | 1671 | colorDepth:24 05:33:11 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 05:33:11 INFO - PROCESS | 1671 | __metrics 05:33:11 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 05:33:12 INFO - TEST-INFO | 1671: exit 0 05:33:12 INFO - Browser initialized. 05:33:12 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:12 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpa1twpn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:24 INFO - PROCESS | 1676 | RSS: Main: 256884736 05:33:24 INFO - PROCESS | 1676 | 05:34:14 INFO - PROCESS | 1676 | 1457789654006 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:36:24 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:36:25 INFO - PROCESS | 1676 | RSS: Main: 269373440 05:36:25 INFO - PROCESS | 1676 | 05:39:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:39:27 INFO - PROCESS | 1676 | RSS: Main: 280313856 05:39:27 INFO - PROCESS | 1676 | 05:42:29 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:42:30 INFO - PROCESS | 1676 | RSS: Main: 282787840 05:42:30 INFO - PROCESS | 1676 | 05:45:32 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:45:32 INFO - PROCESS | 1676 | RSS: Main: 283004928 05:45:32 INFO - PROCESS | 1676 | 05:48:35 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:48:35 INFO - PROCESS | 1676 | RSS: Main: 287580160 05:48:35 INFO - PROCESS | 1676 | 05:51:38 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:51:38 INFO - PROCESS | 1676 | RSS: Main: 288841728 05:51:38 INFO - PROCESS | 1676 | 05:51:38 INFO - PROCESS | 1676 | __start_tp_report 05:51:38 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 05:51:38 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 05:51:38 INFO - PROCESS | 1676 | |i|pagename|runs| 05:51:38 INFO - PROCESS | 1676 | |0;dojo.html;3095.814251144931;3500.7724497907634;3536.876209332674;3567.1973805893676;3578.8926332210026;4539.727616343013;5531;5660.773569057238;5672.347680016799;5712;5467.617266791326;5646.74589643466;5662;5715.285589301327;5785.363610002907;5088.135017047092;5140.383154021522;5173.275741396207;5178.663386879841;5240.6593571417925;362.594411266622;5093.770780314895;5116.1302578561545;5158.845234642967;5217.243499692542;5100.846974590768;5115.769790359424;5123.462036486189;5130.666506677054;5130.897382052338;5092.79628814847;5127.0002349541855;5149.871253218662;5150.9742451287875;5161.948380516184;5123.538881500683;5150.97424512875;5182.326297581328;5209.296744939423;5233.345831771028;4817.0365926814775;5260.184671375943;5553.694546799924;5555.861103472405;5613.971930140323;5962.850928726773;6126.3344663629805;6214.533909956726;6223.719932603044;6237.469815065725;6175.228096487939;6213.068039794067;6252.3435039320675;6274.121622972787;6283.151774510428;5765.855853603652;5778.393268706767;5795.33353664334;5810.738516766755;5839.824805255849;6173.32093469718;6192.876142477216;6283.371662833772;6287.182666253358;6318.8420289492215;6112.138751317739;6112.205413296243;6149.5080393568405;6168.25980882297;6191.597546159485;6214.40963108504;6222.968885155636;6251.531135164881;6281.528885333618;6289.622622642656;6045.78839740607;6136.570440069152;6156;6168.321484636686;6238.594491358047;5647.152927060892;5772.528005358607;6033.939660603425;6123.173371594867;6241.843953901189;4813.422389313305;4879.658423910292;4892.290617860391;4910.140725373046;4953.479884612064;4003.899902502461;4263.616274535245;4296.140771845643;4332.436783218224;4418.513963464016;5578.414266501959;5609.354924183689;5634.802781902696;5656.830295091154;5661.34894487131;6254.15568898202;6263.749450021948;6283.277423096402;6307.117003619497;6311.747530098744;5453.263809385682;5678.858028549319;5703.458171473703;5711.457411545896;5721.22763426932;4599.2871104978785;5336.252924590561;5373.35519737634;5381.0852155133725;5397.7571009304675;6186.721597528122;6283.842903927439;6313.842153946188;6317.368263173646;6326.905096423558;5247.606429517725;6224.502039836892;6243.125962365363;6278.6860656966055;6295.559310848196;6255.958055290883;6309.242890853127;6313.273973492924;6313.368663133833;6336;6042.818715438544;6060.6363618181285;6188.288346840171;6197.535184861244;6225.097360882737;6150.677604315094;6166.630002199882;6237.282712488122;6243.531735119794;6262.655553944394;5512.503874651301;5530.972345138249;5986.970065149646;6088.969555152196;6112.541559382975;5446.618736688394;5883.441073098049;6131.019036954066;6148.83172197299;6155.538334625011;4923.433805112315;5538.086215774352;5791.797287094932;5883.941160588511;5948.910766338595;5942.257217847769;6050.45545900871;6139.969300153471;6141.416565426277;6155.353687862889;4808.783604737865;5747.137929310469;5869.413058694267;5950.047992321208;5968.76124954997 05:51:38 INFO - PROCESS | 1676 | |1;ext.html;503.3984388655556;515.1602887293711;571.6712890088198;602.8251806975977;604.226589964845;37137.628623713754;37747.811260943694;37760.86717398482;37887.621123788755;37971.62028379715;42014.15971680565;42317;42539.14921701564;42676.359854602204;42714.57285427145;9505.619775209001;9778.559964801601;9799.755006124868;9812.313138080337;9812.70561883141;9677.129058384744;9795.118439340458;9803.90196098037;9821.312508124398;9882;9726.367786093917;9797.804043919117;9801.215902727765;9807.509624518781;9811.803763924718;9683.418994860296;9759.365641233297;9770.462624555646;9810.313278070538;9877.802443951152;9657.855132173023;9795.951020244853;9808.95095524525;9836.409815411098;9842.90157098427;39551.40672889909;39750.40374394386;39855.20289594192;40019.7999010006;40028;2950.6606740224934;3199.63204231514;3226.2418331692033;3329.6503867093847;3430.485427185917;26689.599656005175;27223.727762722316;27426.038737118157;27441.725582744115;27621.723782762117;2672.5416933375045;2690.838549687025;2711.8779654915575;2727.386338073937;2789.386335006295;324544.37727811444;325483;326234;327015;327763;61696.76606467935;62314.376856231764;62749.372506275264;62844;62896;70571;81320.18679813245;81516.77724834133;82382.58808706039;82608.58695706603;17582.296708131533;17775.555611109827;17817.93092414459;17842.46472605824;17893.910530447265;13303.40134693941;13325.933925286148;13405.396757145953;13427.462901483832;13434.932825336005;22620.660690089662;22663.320100397013;22823.88588057049;23026.539469210522;23090.769092309198;7804.024496937883;7956.443048986631;8152.38857085721;9294.535273236312;9555.713328600154;920.894097178833;936.9109934556207;1032.1020711980475;1032.1278519650882;1115.7433790228292;29750.40499190004;29781.851090744407;30317.69682303193;30530;30617.08148755541;1091.154355374591;1127.6842484104463;1177.534873724874;1187.5131196209686;1221.9327936963552;15272.923635381752;15390.382135681764;15405.845941540665;15445.845541544666;15594.454194103151;440742;516802;521187;524093;526453;59641.70179149076;61340.07989880155;61928.76142477215;61957.38042619516;62026.689866550376;1444.0469290268582;1444.0685757686233;1456.2936975566843;1471.4187895781106;1471.514400247937;29559.408811823214;31556.053318400485;31557.8422107888;31615.36769264556;32014.039578812673;55933.440665592825;56026.879462411336;56418.589535260304;56688;56866.43133568612;418448;420544;422187;422588;422957;45893.31160032669;46128.76935615435;48516;49655;50385;46736.06527869355;46955.53044469648;47477.28784068311;47877.28184077172;49106;30815;38057;38237.617623823404;38769.6123038766;38903.41644875272;37944.810275948446;39895.40156897591;41382;41418.58581414147;41760.95597610084;40232;40483.19033619252;40629.796851015555;41624.58375416207;42170;30563.08310750681;33076.67693292241;37390.62609373871;38298;39068.413973790986;30548.663907789203;31031;31141.065768026994;31513.527297090102;31831.681683183797 05:51:38 INFO - PROCESS | 1676 | |2;jquery.html;353.35159981434083;366.4704501994618;367.75176755689904;368.3406702003414;369.3057052740847;19906;20485.692714609293;21174.89412552935;21932.671009934842;22130.225442109528;20321.49196270094;20799.584008319824;21040;21077.683834742453;21251.831149286783;5706.7431965561545;5952.017917043704;5965.1052342148805;5975.133605627181;6005.939940600581;5562.582806289524;5733.082706766918;5801.7389217485315;5817.1565123057135;5817.1565123057135;5715.171300161474;5726.284214473191;5741.913871291934;5762.423757624225;5779.682117483537;5572.164175373706;5694.9430505695245;5711.914321285163;5796.536277097822;5809.390014048507;5030.170021946375;5041.395032596112;5041.697498150123;5064.696118232881;5067.189249720064;20658.896705516527;25255.62116568253;25820.225393238234;26121;26206.606900896502;1526.6488707597314;1933.4779609505356;2145.989270053655;2475.8885850136785;2590.818642695012;9825.606975721033;9844.26168037393;10021.695010147634;10133.543990520371;10177.389356638625;1695.5337282247358;1750.9212085456186;1763.7178051511696;1791.0507431061558;1813.1659436659152;101716.49141754318;104373.47813260886;106885.46557267164;108296;110078.44960775145;11222.382768947624;11226.045786108109;11321.377324247245;11443.713907152222;11502.964733174054;13453.260070696206;13502.594922152352;13524.391402386917;13546.525871594644;13558.89837075255;8502.574871256413;8507.532085735344;8570.442921210102;8599.871001934976;8658.78353041179;8434.831303373898;8608.612612432456;8621.870671939925;8696.956515217384;8704.260137888225;4428.82284708608;4469.754163521037;4481.305397663367;4493.842715504941;4518.864434066983;1833.8074502177346;1899.629572233429;1910.703840904662;1952.47283233529;1953.326102494637;900.8243392538392;950.7908260182749;955.6511873166244;996.5814357969671;1041.1618646989095;16720.03659652337;17006.149692515326;17866.91066544659;19752.3086691968;19840.90079549593;925.2690374603987;950.8288508068614;954.2556805691572;960.1982344742079;971.7862070344513;9259.259259259243;10682.252242343116;11050.115990720724;11053.944730276458;11077.833832492519;588072;590845.0457747683;622486;635394;637686;80880.59559702165;108558;109322.45338773256;109789.45105274582;122467.77532224741;989.8515222716507;1004.4776716107438;1025.825609646362;1069.2141276162015;1072.4423299884018;18110.90944545269;18156.636867262318;18297;18320.633587327913;18433.63132737311;46211.76894115508;46669.53330466788;46819;48029.279560807314;50653.49346506635;69367.30632693609;72011.27988720046;73745.63127184544;74221.25778742143;74378.25621743713;6282.748690052346;6449.516286278454;7379.446541509301;7563.243675632392;7985.321247694011;8641.740747777576;10378.377297362182;12368.257904525757;12398.876011240132;12490.188137771016;10328.380297182193;10386.636467723594;10597.62908298206;10673.199510036624;10731.624393146203;10354.792904142025;10372.325798823053;10484.842727358942;10717.303375280582;10739.94630026876;10418.583256669648;10748.623798167027;11014.559417623526;11041.668749937515;11057.723556911142;7658.195889431529;7761.262680045386;7768.223177682186;7770.572618506037;7918.643661035152;10329.225308101772;10622.415767132881;10846.783064338826;10853.186011049045;10881.401522916316 05:51:38 INFO - PROCESS | 1676 | |3;mootools.html;1606.9437569685062;1628.6986907422129;1641.7373220284758;1918.453240826364;1998.6902030185327;8069.112397636255;8680.609372578234;8739.431936924095;8953.104689531052;8981.865272020917;6887.896681549781;8774.385792994493;8889.02220755718;8889.155530224634;8907.68823091192;2419.3104965084954;2436.658867758515;2436.683231179953;2440.7803297703203;2449.069353645612;2447.5104979004273;2470.209532949457;2502.724700282967;2505.8747062646885;2510.0085466240826;2476.702795664523;2480.3675062858947;2494.301595553248;2505.6617356656893;2507.3731567108225;2212.78296936685;2393.9760602393926;2500.1249562653106;2504.887280072401;2514.6982362116482;2467.099508679337;2468.1731619907355;2508.3478295643263;2510.7112682041616;2515.408878913454;8869.955650221773;8871.689490867853;8878.156575125353;8893.28853691703;8912.287017038621;5394.271773310592;5554.805716770914;5593.636413633101;5599.188117722907;5649.265595472562;3601.7118630509494;3706.388445906422;3757.5490941087246;3768.8492460301554;3770.09517715749;1040.0743338428804;1054.5570860238718;1056.4506456642503;1064.4092528646597;1066.6053560182704;11331.526901502752;11931.880681193164;12023.03815694751;12070.758584828254;12104.6368608941;4441.977790111094;4963.31312608031;5041.521055499722;5045.344105266292;5068.746562671851;10243.282970192164;10258.538365773558;10259.974002599829;10261.589536418609;10279.486025698685;5537.1140617501005;5570.2480165177185;5572.247746554244;5576.191452239403;5601.187827764951;4400.691951563424;4892.657513973988;5018.573421259234;5045.621578381636;5089.694618322913;3967.8809635710977;4036.919261614751;4045.7774822384463;4049.615286547832;4093.099518106012;1319.4985905355904;1348.440397235156;1349.925754083535;1355.2884735513935;1372.4715984346099;1160.9013233875046;1333.3799783100906;1379.1931719943746;1394.6443656867434;1401.2923473645744;8192.426530142833;8303.916960830315;8309.169083091763;8355.289800366916;8367.205115514016;508.1336321571711;511.16934980656436;515.51541550942;520.591335801394;526.3631006482123;6311.715972781236;6393.9360606394275;6395.42441180296;6414.454771344488;6417.518686098561;10323.432211228455;10740.892591074145;10807.459627018618;10815.18886083547;10867.184961127947;8816.51509167002;10069.949650251701;10624.946875265574;10629.946850265855;10679.679609611569;6763.898541521881;8259.545724985064;8269.875951860728;8308;8333.791655208546;7727.459077864495;8067.556284404414;8157.0619378769825;8241.464304820167;8260.545669988209;9341.626334946797;9456.905430945877;9570;9585.376950498196;9606.711798646053;9295.86056209171;9595.28035397334;9638.614455421704;9976.401415915068;9995.100440960348;6866.382025617719;7301.977723118874;7479.6634151464405;7561.735339263099;7639.961800190964;7260.854782904418;7962.681492740226;8293;8356.039055508694;8356.997160340798;7205.71177152929;7314.48798584094;7317.743878964211;7472.178060413242;7515;6676.566023208476;6858.353995041254;7253.476769878384;7256.383207427217;7297.379722723415;7680.155182929761;7737.419693522896;7760.767176984699;7858.253465920957;7949.443538952218;7023.086998690138;7093.716251349888;7105.9289407107335;7149;7193.172785129568;7220.350168484862;7272.927270727437;7277.636118194175;7289.963550182428;7295.270472952662 05:51:38 INFO - PROCESS | 1676 | |4;prototype.html;324.17174120123093;326.3831358731996;330.30306054225565;333.1654206213436;334.0279785823253;6054.879847228266;6361.395667411594;6770.96614516928;6803.863922721549;6830.658467076639;6704.564203326792;6757.1891373035305;6765.357291057342;6778.55939363941;6801.149856267966;4770.97614511927;4832;4940.3330550375595;4955.578775804061;4978.054169707753;4922.360093187881;4930.3344048553345;4942.975285123587;4944.332515110468;4945.802167913297;4864;4869.610431165516;4881.8291359802415;4890.77991490382;4896.534829191221;4872.317875497415;4887.14474966883;4887.608991280689;4899;4940.851774446773;4217.8312867485265;4232.195882782262;4246.341817018336;4252.936205956913;4255.14897020594;6237.937620623781;6506.284308726036;6517.185351831021;6543.214814222276;6550.868982620321;4674.789634466457;5750.741216645261;5816.331121920991;5822.796202132905;5841.357450680422;5789.536837053026;7231.168415632217;7233.276672332725;7255.310745479223;7261.801802702601;4621.74580398078;4631.976840115812;4651.674382793206;4656.627469802442;4673.228917228653;7158.642067896636;7519.473636845423;7630.656620452093;7631.54210747357;7633.427492938052;3793.715471339661;4573.954260457419;4633.258678611406;4656.627469802408;4685.672002959828;4301.612854843017;4387.946892745718;4776.379070720784;4799.520047995173;4814.109389762905;5351.598630102758;5665.603407761417;5720.256366672306;5736.311642602915;5744.856378590485;5997.760089596454;7231.5299505531975;7235.638218089074;7241.203467618558;7281.708731650675;1637.3368785641835;1665.916704164787;1667.2997341116761;1669.0486422739166;1672.172274723995;1015.2030655935056;1056.709404913655;1059.2161800267747;1059.6397224943555;1083.3554035348955;6687.364700353459;6687.76592819249;6718.227403848522;6723.924172132533;6740.528163028541;7475.327220550176;7493;7514.135874374408;7519.924800752032;7567.621618919032;6695.12963314766;6695.330466953363;6700.363465470772;6731.865362692719;6770.8645827084165;3848.7113466490127;3954.62431069048;3983.6813054955533;3988.3818008208773;3995.880123596297;7697.114831794415;7741.922580774233;7757.961210193913;7808.180141085218;7834.647440865175;7671.6164191790185;7671.731489397845;7677;7684.3084122429245;7708.537487750753;6783.796486105425;7498.437617178624;7697.461177717506;7753.767386978399;7783.766487005399;7094.787156385317;7480.0649918760155;7495.700171993278;7501.699932002877;7502.812429689301;7258.600776957107;7293.234210408043;7315.890261646186;7355.632218388952;7365;6830.59016459014;7751.844963100819;7766.106897706836;7770.53376797394;7795.142534321333;3528.8235588221;4700.741459219776;4705.576498115186;4711.411073615798;4719.457262414729;6847.315268473113;7424.740134095281;7463.141738700119;7476.962615186889;7492.62536873165;5810.76756929735;7266.091738532684;7280.490365674352;7289.671964761493;7302.306280903305;5982.581219314607;7202.89195662055;7239.601821899846;7246.130464344313;7269.236730143471;5434.456554344534;7079.539829911039;7094.396976257076;7142.071530700976;7156.821079473055;7001.36987671112;7243.420526357773;7248.238934911969;7284.890726639211;7316.707331706885;7025.508214424941;7042.647867606497;7060.752873649398;7061.152661680426;7100.325469080429 05:51:38 INFO - PROCESS | 1676 | |5;yui.html;684.2780866186173;703.9683214255358;722.8373615936415;734.6179986407066;784.4900814470593;12393.318367489806;12741.362931853417;14859.40562377505;15094.320755566;15117;12640.810387844189;12860.292683902382;13125.474981000749;15803.604909877258;15961.680766384665;919.8620206968958;936.7423958411423;938.3103418987073;939.5067589515525;943.9622415103422;714.9571025738446;918.2883265469281;928.470771660154;937.3298091864316;949.2690628216304;973.4986481961795;986.4574484033789;992.6972273456593;993.662154867345;994.6866736977865;948.6395169835488;975.3416443900375;976.4092723902008;982.017982017982;985.3841349156777;721.0698199322867;725.0900120348929;735.0627949364549;735.477810754365;739.2127384335665;15137.545873623809;15327.770083448757;15394.769078463833;15414.768778468331;15450.9227453862;12393.256404615751;12467.625971220878;12548.623541293684;12659.683507912283;12699;8812.471251724917;9235.676751313738;10006.899241083474;10586.470676466146;10595.68212953605;3412.8566930078455;3423.058658868806;3465.4801779733243;3491.5286436331025;3529.1882866940746;82968;83864.16135838625;83986.3202735948;84057.57971210228;85375;7563.886541701879;9302.116298951589;9306.441613503212;9364.90635093654;9651.951740241395;15789.131597762003;20962.790372096082;21348.466288342916;21355.25256616011;21411.46471338229;5645.2096706461125;6303.802277567339;6936.895946560806;6969.965150174216;7505.774826755206;3946.565877753445;4007.238624661305;4010.2618155060873;4021.4571032910767;4072.165206132736;3125.1405863387295;3473.7568370213844;3507.456719043613;3595.2449985503335;3620.71034317254;542.6472792684787;615.6275453350659;634.8190765631773;658.9275179730225;661.0183876942737;480.5962991087503;578.0462237308475;584.7047241143196;615.0681717198448;625.4621025917708;7451.478396512192;7927.128015918244;7978.880316795253;7979.72070977513;8005.759827205193;544.9373322068013;547.9780808767684;556.4908109080146;565.6916980245776;573.1059547106527;3616.833299224815;3742.4760533525327;3747.2130852521277;3834.8155918014154;3847.245812309823;77691.61154194192;78880;79398;79762.60118699369;80678;68519;73509;73732.63133684297;74224.62887685528;74565;67026;67062.66468667626;67970.99999999901;68141.23011389155;68263.3173668257;7496.7376141834775;7518.323350898446;7521;7558.13081495613;7749.457537972288;49106.50893491019;49730.751346243036;49887.50112498829;50357.74821126017;50407.24389134093;58560.70719646374;60245.698771505864;61725;64532;65342.67328663326;9586.11071129011;9603.855942160733;9686.70939871805;9854.408735475894;9905.702828915144;10304.845427318447;10403.271770975958;10425.739356516147;10668.413237272025;11323.490442929924;10013.198944084601;10318.845217321596;10334.276600637882;10336.0697537222;10378.481075946022;9843.803123937625;10020.69937901864;10246.487675616041;10260.743481413025;10439.164866810484;9673.758156046155;10633.713751543455;11036.11711063129;11492.310461372344;11692.415379231175;8681.871356723586;9293.210077143518;9497.28770342241;9676.758081047748;9691.854622180814;8581.843429959928;9590.712278631652;9619.086186812241;9625.51872406391;9690.95154524223 05:51:38 INFO - PROCESS | 1676 | __end_tp_report 05:51:38 INFO - PROCESS | 1676 | __start_cc_report 05:51:38 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,366 05:51:38 INFO - PROCESS | 1676 | __end_cc_report 05:51:38 INFO - PROCESS | 1676 | __startTimestamp1457790698841__endTimestamp 05:51:38 INFO - PROCESS | 1676 | 05:51:38 INFO - PROCESS | 1676 | ------- Summary: start ------- 05:51:38 INFO - PROCESS | 1676 | Number of tests: 6 05:51:38 INFO - PROCESS | 1676 | 05:51:38 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5628.80 Median:5791.80 stddev:777.77 (13.4%) stddev-sans-first:754.34 05:51:38 INFO - PROCESS | 1676 | Values: 3095.8 3500.8 3536.9 3567.2 3578.9 4539.7 5531.0 5660.8 5672.3 5712.0 5467.6 5646.7 5662.0 5715.3 5785.4 5088.1 5140.4 5173.3 5178.7 5240.7 362.6 5093.8 5116.1 5158.8 5217.2 5100.8 5115.8 5123.5 5130.7 5130.9 5092.8 5127.0 5149.9 5151.0 5161.9 5123.5 5151.0 5182.3 5209.3 5233.3 4817.0 5260.2 5553.7 5555.9 5614.0 5962.9 6126.3 6214.5 6223.7 6237.5 6175.2 6213.1 6252.3 6274.1 6283.2 5765.9 5778.4 5795.3 5810.7 5839.8 6173.3 6192.9 6283.4 6287.2 6318.8 6112.1 6112.2 6149.5 6168.3 6191.6 6214.4 6223.0 6251.5 6281.5 6289.6 6045.8 6136.6 6156.0 6168.3 6238.6 5647.2 5772.5 6033.9 6123.2 6241.8 4813.4 4879.7 4892.3 4910.1 4953.5 4003.9 4263.6 4296.1 4332.4 4418.5 5578.4 5609.4 5634.8 5656.8 5661.3 6254.2 6263.7 6283.3 6307.1 6311.7 5453.3 5678.9 5703.5 5711.5 5721.2 4599.3 5336.3 5373.4 5381.1 5397.8 6186.7 6283.8 6313.8 6317.4 6326.9 5247.6 6224.5 6243.1 6278.7 6295.6 6256.0 6309.2 6313.3 6313.4 6336.0 6042.8 6060.6 6188.3 6197.5 6225.1 6150.7 6166.6 6237.3 6243.5 6262.7 5512.5 5531.0 5987.0 6089.0 6112.5 5446.6 5883.4 6131.0 6148.8 6155.5 4923.4 5538.1 5791.8 5883.9 5948.9 5942.3 6050.5 6140.0 6141.4 6155.4 4808.8 5747.1 5869.4 5950.0 5968.8 05:51:38 INFO - PROCESS | 1676 | 05:51:38 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:59450.00 Median:40357.60 stddev:112328.98 (278.3%) stddev-sans-first:112556.90 05:51:38 INFO - PROCESS | 1676 | Values: 503.4 515.2 571.7 602.8 604.2 37137.6 37747.8 37760.9 37887.6 37971.6 42014.2 42317.0 42539.1 42676.4 42714.6 9505.6 9778.6 9799.8 9812.3 9812.7 9677.1 9795.1 9803.9 9821.3 9882.0 9726.4 9797.8 9801.2 9807.5 9811.8 9683.4 9759.4 9770.5 9810.3 9877.8 9657.9 9796.0 9809.0 9836.4 9842.9 39551.4 39750.4 39855.2 40019.8 40028.0 2950.7 3199.6 3226.2 3329.7 3430.5 26689.6 27223.7 27426.0 27441.7 27621.7 2672.5 2690.8 2711.9 2727.4 2789.4 324544.4 325483.0 326234.0 327015.0 327763.0 61696.8 62314.4 62749.4 62844.0 62896.0 70571.0 81320.2 81516.8 82382.6 82608.6 17582.3 17775.6 17817.9 17842.5 17893.9 13303.4 13325.9 13405.4 13427.5 13434.9 22620.7 22663.3 22823.9 23026.5 23090.8 7804.0 7956.4 8152.4 9294.5 9555.7 920.9 936.9 1032.1 1032.1 1115.7 29750.4 29781.9 30317.7 30530.0 30617.1 1091.2 1127.7 1177.5 1187.5 1221.9 15272.9 15390.4 15405.8 15445.8 15594.5 440742.0 516802.0 521187.0 524093.0 526453.0 59641.7 61340.1 61928.8 61957.4 62026.7 1444.0 1444.1 1456.3 1471.4 1471.5 29559.4 31556.1 31557.8 31615.4 32014.0 55933.4 56026.9 56418.6 56688.0 56866.4 418448.0 420544.0 422187.0 422588.0 422957.0 45893.3 46128.8 48516.0 49655.0 50385.0 46736.1 46955.5 47477.3 47877.3 49106.0 30815.0 38057.0 38237.6 38769.6 38903.4 37944.8 39895.4 41382.0 41418.6 41761.0 40232.0 40483.2 40629.8 41624.6 42170.0 30563.1 33076.7 37390.6 38298.0 39068.4 30548.7 31031.0 31141.1 31513.5 31831.7 05:51:38 INFO - PROCESS | 1676 | 05:51:38 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:34010.62 Median:25537.92 stddev:101797.74 (398.6%) stddev-sans-first:102051.94 05:51:38 INFO - PROCESS | 1676 | Values: 353.4 366.5 367.8 368.3 369.3 19906.0 20485.7 21174.9 21932.7 22130.2 20321.5 20799.6 21040.0 21077.7 21251.8 5706.7 5952.0 5965.1 5975.1 6005.9 5562.6 5733.1 5801.7 5817.2 5817.2 5715.2 5726.3 5741.9 5762.4 5779.7 5572.2 5694.9 5711.9 5796.5 5809.4 5030.2 5041.4 5041.7 5064.7 5067.2 20658.9 25255.6 25820.2 26121.0 26206.6 1526.6 1933.5 2146.0 2475.9 2590.8 9825.6 9844.3 10021.7 10133.5 10177.4 1695.5 1750.9 1763.7 1791.1 1813.2 101716.5 104373.5 106885.5 108296.0 110078.4 11222.4 11226.0 11321.4 11443.7 11503.0 13453.3 13502.6 13524.4 13546.5 13558.9 8502.6 8507.5 8570.4 8599.9 8658.8 8434.8 8608.6 8621.9 8697.0 8704.3 4428.8 4469.8 4481.3 4493.8 4518.9 1833.8 1899.6 1910.7 1952.5 1953.3 900.8 950.8 955.7 996.6 1041.2 16720.0 17006.1 17866.9 19752.3 19840.9 925.3 950.8 954.3 960.2 971.8 9259.3 10682.3 11050.1 11053.9 11077.8 588072.0 590845.0 622486.0 635394.0 637686.0 80880.6 108558.0 109322.5 109789.5 122467.8 989.9 1004.5 1025.8 1069.2 1072.4 18110.9 18156.6 18297.0 18320.6 18433.6 46211.8 46669.5 46819.0 48029.3 50653.5 69367.3 72011.3 73745.6 74221.3 74378.3 6282.7 6449.5 7379.4 7563.2 7985.3 8641.7 10378.4 12368.3 12398.9 12490.2 10328.4 10386.6 10597.6 10673.2 10731.6 10354.8 10372.3 10484.8 10717.3 10739.9 10418.6 10748.6 11014.6 11041.7 11057.7 7658.2 7761.3 7768.2 7770.6 7918.6 10329.2 10622.4 10846.8 10853.2 10881.4 05:51:38 INFO - PROCESS | 1676 | 05:51:38 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:6058.95 Median:5545.96 stddev:3177.27 (57.3%) stddev-sans-first:3168.57 05:51:38 INFO - PROCESS | 1676 | Values: 1606.9 1628.7 1641.7 1918.5 1998.7 8069.1 8680.6 8739.4 8953.1 8981.9 6887.9 8774.4 8889.0 8889.2 8907.7 2419.3 2436.7 2436.7 2440.8 2449.1 2447.5 2470.2 2502.7 2505.9 2510.0 2476.7 2480.4 2494.3 2505.7 2507.4 2212.8 2394.0 2500.1 2504.9 2514.7 2467.1 2468.2 2508.3 2510.7 2515.4 8870.0 8871.7 8878.2 8893.3 8912.3 5394.3 5554.8 5593.6 5599.2 5649.3 3601.7 3706.4 3757.5 3768.8 3770.1 1040.1 1054.6 1056.5 1064.4 1066.6 11331.5 11931.9 12023.0 12070.8 12104.6 4442.0 4963.3 5041.5 5045.3 5068.7 10243.3 10258.5 10260.0 10261.6 10279.5 5537.1 5570.2 5572.2 5576.2 5601.2 4400.7 4892.7 5018.6 5045.6 5089.7 3967.9 4036.9 4045.8 4049.6 4093.1 1319.5 1348.4 1349.9 1355.3 1372.5 1160.9 1333.4 1379.2 1394.6 1401.3 8192.4 8303.9 8309.2 8355.3 8367.2 508.1 511.2 515.5 520.6 526.4 6311.7 6393.9 6395.4 6414.5 6417.5 10323.4 10740.9 10807.5 10815.2 10867.2 8816.5 10069.9 10624.9 10629.9 10679.7 6763.9 8259.5 8269.9 8308.0 8333.8 7727.5 8067.6 8157.1 8241.5 8260.5 9341.6 9456.9 9570.0 9585.4 9606.7 9295.9 9595.3 9638.6 9976.4 9995.1 6866.4 7302.0 7479.7 7561.7 7640.0 7260.9 7962.7 8293.0 8356.0 8357.0 7205.7 7314.5 7317.7 7472.2 7515.0 6676.6 6858.4 7253.5 7256.4 7297.4 7680.2 7737.4 7760.8 7858.3 7949.4 7023.1 7093.7 7105.9 7149.0 7193.2 7220.4 7272.9 7277.6 7290.0 7295.3 05:51:38 INFO - PROCESS | 1676 | 05:51:38 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:5837.13 Median:6697.85 stddev:1892.07 (28.2%) stddev-sans-first:1851.58 05:51:38 INFO - PROCESS | 1676 | Values: 324.2 326.4 330.3 333.2 334.0 6054.9 6361.4 6771.0 6803.9 6830.7 6704.6 6757.2 6765.4 6778.6 6801.1 4771.0 4832.0 4940.3 4955.6 4978.1 4922.4 4930.3 4943.0 4944.3 4945.8 4864.0 4869.6 4881.8 4890.8 4896.5 4872.3 4887.1 4887.6 4899.0 4940.9 4217.8 4232.2 4246.3 4252.9 4255.1 6237.9 6506.3 6517.2 6543.2 6550.9 4674.8 5750.7 5816.3 5822.8 5841.4 5789.5 7231.2 7233.3 7255.3 7261.8 4621.7 4632.0 4651.7 4656.6 4673.2 7158.6 7519.5 7630.7 7631.5 7633.4 3793.7 4574.0 4633.3 4656.6 4685.7 4301.6 4387.9 4776.4 4799.5 4814.1 5351.6 5665.6 5720.3 5736.3 5744.9 5997.8 7231.5 7235.6 7241.2 7281.7 1637.3 1665.9 1667.3 1669.0 1672.2 1015.2 1056.7 1059.2 1059.6 1083.4 6687.4 6687.8 6718.2 6723.9 6740.5 7475.3 7493.0 7514.1 7519.9 7567.6 6695.1 6695.3 6700.4 6731.9 6770.9 3848.7 3954.6 3983.7 3988.4 3995.9 7697.1 7741.9 7758.0 7808.2 7834.6 7671.6 7671.7 7677.0 7684.3 7708.5 6783.8 7498.4 7697.5 7753.8 7783.8 7094.8 7480.1 7495.7 7501.7 7502.8 7258.6 7293.2 7315.9 7355.6 7365.0 6830.6 7751.8 7766.1 7770.5 7795.1 3528.8 4700.7 4705.6 4711.4 4719.5 6847.3 7424.7 7463.1 7477.0 7492.6 5810.8 7266.1 7280.5 7289.7 7302.3 5982.6 7202.9 7239.6 7246.1 7269.2 5434.5 7079.5 7094.4 7142.1 7156.8 7001.4 7243.4 7248.2 7284.9 7316.7 7025.5 7042.6 7060.8 7061.2 7100.3 05:51:38 INFO - PROCESS | 1676 | 05:51:38 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:17369.08 Median:33000.80 stddev:24257.54 (73.5%) stddev-sans-first:24293.23 05:51:38 INFO - PROCESS | 1676 | Values: 684.3 704.0 722.8 734.6 784.5 12393.3 12741.4 14859.4 15094.3 15117.0 12640.8 12860.3 13125.5 15803.6 15961.7 919.9 936.7 938.3 939.5 944.0 715.0 918.3 928.5 937.3 949.3 973.5 986.5 992.7 993.7 994.7 948.6 975.3 976.4 982.0 985.4 721.1 725.1 735.1 735.5 739.2 15137.5 15327.8 15394.8 15414.8 15450.9 12393.3 12467.6 12548.6 12659.7 12699.0 8812.5 9235.7 10006.9 10586.5 10595.7 3412.9 3423.1 3465.5 3491.5 3529.2 82968.0 83864.2 83986.3 84057.6 85375.0 7563.9 9302.1 9306.4 9364.9 9652.0 15789.1 20962.8 21348.5 21355.3 21411.5 5645.2 6303.8 6936.9 6970.0 7505.8 3946.6 4007.2 4010.3 4021.5 4072.2 3125.1 3473.8 3507.5 3595.2 3620.7 542.6 615.6 634.8 658.9 661.0 480.6 578.0 584.7 615.1 625.5 7451.5 7927.1 7978.9 7979.7 8005.8 544.9 548.0 556.5 565.7 573.1 3616.8 3742.5 3747.2 3834.8 3847.2 77691.6 78880.0 79398.0 79762.6 80678.0 68519.0 73509.0 73732.6 74224.6 74565.0 67026.0 67062.7 67971.0 68141.2 68263.3 7496.7 7518.3 7521.0 7558.1 7749.5 49106.5 49730.8 49887.5 50357.7 50407.2 58560.7 60245.7 61725.0 64532.0 65342.7 9586.1 9603.9 9686.7 9854.4 9905.7 10304.8 10403.3 10425.7 10668.4 11323.5 10013.2 10318.8 10334.3 10336.1 10378.5 9843.8 10020.7 10246.5 10260.7 10439.2 9673.8 10633.7 11036.1 11492.3 11692.4 8681.9 9293.2 9497.3 9676.8 9691.9 8581.8 9590.7 9619.1 9625.5 9691.0 05:51:38 INFO - PROCESS | 1676 | -------- Summary: end -------- 05:51:38 INFO - PROCESS | 1676 | 05:51:39 INFO - TEST-INFO | 1676: exit 0 05:51:39 INFO - TEST-OK | dromaeo_css | took 1111182ms 05:51:39 INFO - TEST-START | kraken 05:51:39 INFO - operating with platform_type : mac_ 05:51:39 INFO - Initialising browser for kraken test... 05:51:39 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpJHBo_g/profile http://localhost:49274/getInfo.html) 05:51:42 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 05:51:42 INFO - PROCESS | 1683 | colorDepth:24 05:51:42 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 05:51:42 INFO - PROCESS | 1683 | __metrics 05:51:42 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 05:51:43 INFO - TEST-INFO | 1683: exit 0 05:51:43 INFO - Browser initialized. 05:51:43 INFO - Running cycle 1/1 for kraken test... 05:51:43 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpJHBo_g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:55 INFO - PROCESS | 1686 | RSS: Main: 257228800 05:51:55 INFO - PROCESS | 1686 | 05:51:57 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 05:51:58 INFO - PROCESS | 1686 | RSS: Main: 267644928 05:51:58 INFO - PROCESS | 1686 | 05:52:01 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 05:52:01 INFO - PROCESS | 1686 | RSS: Main: 277078016 05:52:01 INFO - PROCESS | 1686 | 05:52:05 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 05:52:05 INFO - PROCESS | 1686 | RSS: Main: 281960448 05:52:05 INFO - PROCESS | 1686 | 05:52:07 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 05:52:08 INFO - PROCESS | 1686 | RSS: Main: 282820608 05:52:08 INFO - PROCESS | 1686 | 05:52:10 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:11 INFO - PROCESS | 1686 | RSS: Main: 284545024 05:52:11 INFO - PROCESS | 1686 | 05:52:14 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:14 INFO - PROCESS | 1686 | RSS: Main: 284168192 05:52:14 INFO - PROCESS | 1686 | 05:52:17 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:18 INFO - PROCESS | 1686 | RSS: Main: 284270592 05:52:18 INFO - PROCESS | 1686 | 05:52:21 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 05:52:21 INFO - PROCESS | 1686 | RSS: Main: 284368896 05:52:21 INFO - PROCESS | 1686 | 05:52:23 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:24 INFO - PROCESS | 1686 | RSS: Main: 282918912 05:52:24 INFO - PROCESS | 1686 | 05:52:25 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:26 INFO - PROCESS | 1686 | RSS: Main: 283697152 05:52:26 INFO - PROCESS | 1686 | 05:52:28 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:29 INFO - PROCESS | 1686 | RSS: Main: 282931200 05:52:29 INFO - PROCESS | 1686 | 05:52:31 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:32 INFO - PROCESS | 1686 | RSS: Main: 283041792 05:52:32 INFO - PROCESS | 1686 | 05:52:35 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:35 INFO - PROCESS | 1686 | RSS: Main: 284352512 05:52:35 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 05:52:37 INFO - PROCESS | 1686 | RSS: Main: 284393472 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | __start_tp_report 05:52:37 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 05:52:37 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 05:52:37 INFO - PROCESS | 1686 | |i|pagename|runs| 05:52:37 INFO - PROCESS | 1686 | |0;ai-astar;114;109;131;113;113;127;155;116;93;164 05:52:37 INFO - PROCESS | 1686 | |1;audio-beat-detection;149;125;142;154;159;178;138;122;156;121 05:52:37 INFO - PROCESS | 1686 | |2;audio-dft;196;197;201;180;265;280;241;203;201;202 05:52:37 INFO - PROCESS | 1686 | |3;audio-fft;61;74;57;61;70;99;142;75;56;61 05:52:37 INFO - PROCESS | 1686 | |4;audio-oscillator;87;63;158;114;124;120;125;81;81;115 05:52:37 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;92;89;106;131;112;88;93;111;123;108 05:52:37 INFO - PROCESS | 1686 | |6;imaging-darkroom;108;96;96;106;108;153;152;97;96;104 05:52:37 INFO - PROCESS | 1686 | |7;imaging-desaturate;90;94;94;91;100;110;115;76;152;90 05:52:37 INFO - PROCESS | 1686 | |8;json-parse-financial;58;57;55;56;55;58;57;75;80;86 05:52:37 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;67;68;73;72;66;66;66;65;66;68 05:52:37 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;84;82;89;89;84;84;87;87;86;83 05:52:37 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;132;122;145;132;142;135;126;130;123;141 05:52:37 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;144;143;143;142;143;148;145;142;142;132 05:52:37 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;72;71;67;69;69;73;95;99;102;64 05:52:37 INFO - PROCESS | 1686 | __end_tp_report 05:52:37 INFO - PROCESS | 1686 | __start_cc_report 05:52:37 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,953 05:52:37 INFO - PROCESS | 1686 | __end_cc_report 05:52:37 INFO - PROCESS | 1686 | __startTimestamp1457790757684__endTimestamp 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | ------- Summary: start ------- 05:52:37 INFO - PROCESS | 1686 | Number of tests: 14 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:123.50 Median:129.00 stddev:21.62 (16.8%) stddev-sans-first:22.66 05:52:37 INFO - PROCESS | 1686 | Values: 114.0 109.0 131.0 113.0 113.0 127.0 155.0 116.0 93.0 164.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:151.50 stddev:18.45 (12.2%) stddev-sans-first:19.49 05:52:37 INFO - PROCESS | 1686 | Values: 149.0 125.0 142.0 154.0 159.0 178.0 138.0 122.0 156.0 121.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:216.60 Median:202.50 stddev:33.32 (16.5%) stddev-sans-first:34.49 05:52:37 INFO - PROCESS | 1686 | Values: 196.0 197.0 201.0 180.0 265.0 280.0 241.0 203.0 201.0 202.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:75.60 Median:65.50 stddev:26.58 (40.6%) stddev-sans-first:27.67 05:52:37 INFO - PROCESS | 1686 | Values: 61.0 74.0 57.0 61.0 70.0 99.0 142.0 75.0 56.0 61.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:110.50 stddev:28.25 (25.6%) stddev-sans-first:29.04 05:52:37 INFO - PROCESS | 1686 | Values: 87.0 63.0 158.0 114.0 124.0 120.0 125.0 81.0 81.0 115.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:105.30 Median:109.50 stddev:14.73 (13.4%) stddev-sans-first:14.81 05:52:37 INFO - PROCESS | 1686 | Values: 92.0 89.0 106.0 131.0 112.0 88.0 93.0 111.0 123.0 108.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:111.60 Median:124.50 stddev:22.12 (17.8%) stddev-sans-first:23.43 05:52:37 INFO - PROCESS | 1686 | Values: 108.0 96.0 96.0 106.0 108.0 153.0 152.0 97.0 96.0 104.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:101.20 Median:90.00 stddev:20.93 (23.3%) stddev-sans-first:21.81 05:52:37 INFO - PROCESS | 1686 | Values: 90.0 94.0 94.0 91.0 100.0 110.0 115.0 76.0 152.0 90.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:58.00 stddev:11.81 (20.4%) stddev-sans-first:12.35 05:52:37 INFO - PROCESS | 1686 | Values: 58.0 57.0 55.0 56.0 55.0 58.0 57.0 75.0 80.0 86.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.50 stddev:2.71 (4.0%) stddev-sans-first:2.86 05:52:37 INFO - PROCESS | 1686 | Values: 67.0 68.0 73.0 72.0 66.0 66.0 66.0 65.0 66.0 68.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.50 stddev:2.46 (2.8%) stddev-sans-first:2.55 05:52:37 INFO - PROCESS | 1686 | Values: 84.0 82.0 89.0 89.0 84.0 84.0 87.0 87.0 86.0 83.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:133.50 stddev:7.98 (6.0%) stddev-sans-first:8.46 05:52:37 INFO - PROCESS | 1686 | Values: 132.0 122.0 145.0 132.0 142.0 135.0 126.0 130.0 123.0 141.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:143.00 stddev:4.09 (2.9%) stddev-sans-first:4.29 05:52:37 INFO - PROCESS | 1686 | Values: 144.0 143.0 143.0 142.0 143.0 148.0 145.0 142.0 142.0 132.0 05:52:37 INFO - PROCESS | 1686 | 05:52:37 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.10 Median:71.50 stddev:14.51 (20.3%) stddev-sans-first:15.22 05:52:37 INFO - PROCESS | 1686 | Values: 72.0 71.0 67.0 69.0 69.0 73.0 95.0 99.0 102.0 64.0 05:52:37 INFO - PROCESS | 1686 | -------- Summary: end -------- 05:52:37 INFO - PROCESS | 1686 | 05:52:38 INFO - TEST-INFO | 1686: exit 0 05:52:38 INFO - TEST-OK | kraken | took 59047ms 05:52:38 INFO - SUITE-END | took 1170s 05:52:38 INFO - Completed test suite (00:19:30) 05:52:38 INFO - javascript benchmark 05:52:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3095.814251144931, 3500.7724497907634, 3536.876209332674, 3567.1973805893676, 3578.8926332210026, 4539.727616343013, 5531.0, 5660.773569057238, 5672.347680016799, 5712.0, 5467.617266791326, 5646.74589643466, 5662.0, 5715.285589301327, 5785.363610002907, 5088.135017047092, 5140.383154021522, 5173.275741396207, 5178.663386879841, 5240.6593571417925, 362.594411266622, 5093.770780314895, 5116.1302578561545, 5158.845234642967, 5217.243499692542, 5100.846974590768, 5115.769790359424, 5123.462036486189, 5130.666506677054, 5130.897382052338, 5092.79628814847, 5127.0002349541855, 5149.871253218662, 5150.9742451287875, 5161.948380516184, 5123.538881500683, 5150.97424512875, 5182.326297581328, 5209.296744939423, 5233.345831771028, 4817.0365926814775, 5260.184671375943, 5553.694546799924, 5555.861103472405, 5613.971930140323, 5962.850928726773, 6126.3344663629805, 6214.533909956726, 6223.719932603044, 6237.469815065725, 6175.228096487939, 6213.068039794067, 6252.3435039320675, 6274.121622972787, 6283.151774510428, 5765.855853603652, 5778.393268706767, 5795.33353664334, 5810.738516766755, 5839.824805255849, 6173.32093469718, 6192.876142477216, 6283.371662833772, 6287.182666253358, 6318.8420289492215, 6112.138751317739, 6112.205413296243, 6149.5080393568405, 6168.25980882297, 6191.597546159485, 6214.40963108504, 6222.968885155636, 6251.531135164881, 6281.528885333618, 6289.622622642656, 6045.78839740607, 6136.570440069152, 6156.0, 6168.321484636686, 6238.594491358047, 5647.152927060892, 5772.528005358607, 6033.939660603425, 6123.173371594867, 6241.843953901189, 4813.422389313305, 4879.658423910292, 4892.290617860391, 4910.140725373046, 4953.479884612064, 4003.899902502461, 4263.616274535245, 4296.140771845643, 4332.436783218224, 4418.513963464016, 5578.414266501959, 5609.354924183689, 5634.802781902696, 5656.830295091154, 5661.34894487131, 6254.15568898202, 6263.749450021948, 6283.277423096402, 6307.117003619497, 6311.747530098744, 5453.263809385682, 5678.858028549319, 5703.458171473703, 5711.457411545896, 5721.22763426932, 4599.2871104978785, 5336.252924590561, 5373.35519737634, 5381.0852155133725, 5397.7571009304675, 6186.721597528122, 6283.842903927439, 6313.842153946188, 6317.368263173646, 6326.905096423558, 5247.606429517725, 6224.502039836892, 6243.125962365363, 6278.6860656966055, 6295.559310848196, 6255.958055290883, 6309.242890853127, 6313.273973492924, 6313.368663133833, 6336.0, 6042.818715438544, 6060.6363618181285, 6188.288346840171, 6197.535184861244, 6225.097360882737, 6150.677604315094, 6166.630002199882, 6237.282712488122, 6243.531735119794, 6262.655553944394, 5512.503874651301, 5530.972345138249, 5986.970065149646, 6088.969555152196, 6112.541559382975, 5446.618736688394, 5883.441073098049, 6131.019036954066, 6148.83172197299, 6155.538334625011, 4923.433805112315, 5538.086215774352, 5791.797287094932, 5883.941160588511, 5948.910766338595, 5942.257217847769, 6050.45545900871, 6139.969300153471, 6141.416565426277, 6155.353687862889, 4808.783604737865, 5747.137929310469, 5869.413058694267, 5950.047992321208, 5968.76124954997], "unit": "score", "name": "dojo.html", "value": 5582.2910975084915}, {"lowerIsBetter": false, "replicates": [503.3984388655556, 515.1602887293711, 571.6712890088198, 602.8251806975977, 604.226589964845, 37137.628623713754, 37747.811260943694, 37760.86717398482, 37887.621123788755, 37971.62028379715, 42014.15971680565, 42317.0, 42539.14921701564, 42676.359854602204, 42714.57285427145, 9505.619775209001, 9778.559964801601, 9799.755006124868, 9812.313138080337, 9812.70561883141, 9677.129058384744, 9795.118439340458, 9803.90196098037, 9821.312508124398, 9882.0, 9726.367786093917, 9797.804043919117, 9801.215902727765, 9807.509624518781, 9811.803763924718, 9683.418994860296, 9759.365641233297, 9770.462624555646, 9810.313278070538, 9877.802443951152, 9657.855132173023, 9795.951020244853, 9808.95095524525, 9836.409815411098, 9842.90157098427, 39551.40672889909, 39750.40374394386, 39855.20289594192, 40019.7999010006, 40028.0, 2950.6606740224934, 3199.63204231514, 3226.2418331692033, 3329.6503867093847, 3430.485427185917, 26689.599656005175, 27223.727762722316, 27426.038737118157, 27441.725582744115, 27621.723782762117, 2672.5416933375045, 2690.838549687025, 2711.8779654915575, 2727.386338073937, 2789.386335006295, 324544.37727811444, 325483.0, 326234.0, 327015.0, 327763.0, 61696.76606467935, 62314.376856231764, 62749.372506275264, 62844.0, 62896.0, 70571.0, 81320.18679813245, 81516.77724834133, 82382.58808706039, 82608.58695706603, 17582.296708131533, 17775.555611109827, 17817.93092414459, 17842.46472605824, 17893.910530447265, 13303.40134693941, 13325.933925286148, 13405.396757145953, 13427.462901483832, 13434.932825336005, 22620.660690089662, 22663.320100397013, 22823.88588057049, 23026.539469210522, 23090.769092309198, 7804.024496937883, 7956.443048986631, 8152.38857085721, 9294.535273236312, 9555.713328600154, 920.894097178833, 936.9109934556207, 1032.1020711980475, 1032.1278519650882, 1115.7433790228292, 29750.40499190004, 29781.851090744407, 30317.69682303193, 30530.0, 30617.08148755541, 1091.154355374591, 1127.6842484104463, 1177.534873724874, 1187.5131196209686, 1221.9327936963552, 15272.923635381752, 15390.382135681764, 15405.845941540665, 15445.845541544666, 15594.454194103151, 440742.0, 516802.0, 521187.0, 524093.0, 526453.0, 59641.70179149076, 61340.07989880155, 61928.76142477215, 61957.38042619516, 62026.689866550376, 1444.0469290268582, 1444.0685757686233, 1456.2936975566843, 1471.4187895781106, 1471.514400247937, 29559.408811823214, 31556.053318400485, 31557.8422107888, 31615.36769264556, 32014.039578812673, 55933.440665592825, 56026.879462411336, 56418.589535260304, 56688.0, 56866.43133568612, 418448.0, 420544.0, 422187.0, 422588.0, 422957.0, 45893.31160032669, 46128.76935615435, 48516.0, 49655.0, 50385.0, 46736.06527869355, 46955.53044469648, 47477.28784068311, 47877.28184077172, 49106.0, 30815.0, 38057.0, 38237.617623823404, 38769.6123038766, 38903.41644875272, 37944.810275948446, 39895.40156897591, 41382.0, 41418.58581414147, 41760.95597610084, 40232.0, 40483.19033619252, 40629.796851015555, 41624.58375416207, 42170.0, 30563.08310750681, 33076.67693292241, 37390.62609373871, 38298.0, 39068.413973790986, 30548.663907789203, 31031.0, 31141.065768026994, 31513.527297090102, 31831.681683183797], "unit": "score", "name": "ext.html", "value": 20496.60973064242}, {"lowerIsBetter": false, "replicates": [353.35159981434083, 366.4704501994618, 367.75176755689904, 368.3406702003414, 369.3057052740847, 19906.0, 20485.692714609293, 21174.89412552935, 21932.671009934842, 22130.225442109528, 20321.49196270094, 20799.584008319824, 21040.0, 21077.683834742453, 21251.831149286783, 5706.7431965561545, 5952.017917043704, 5965.1052342148805, 5975.133605627181, 6005.939940600581, 5562.582806289524, 5733.082706766918, 5801.7389217485315, 5817.1565123057135, 5817.1565123057135, 5715.171300161474, 5726.284214473191, 5741.913871291934, 5762.423757624225, 5779.682117483537, 5572.164175373706, 5694.9430505695245, 5711.914321285163, 5796.536277097822, 5809.390014048507, 5030.170021946375, 5041.395032596112, 5041.697498150123, 5064.696118232881, 5067.189249720064, 20658.896705516527, 25255.62116568253, 25820.225393238234, 26121.0, 26206.606900896502, 1526.6488707597314, 1933.4779609505356, 2145.989270053655, 2475.8885850136785, 2590.818642695012, 9825.606975721033, 9844.26168037393, 10021.695010147634, 10133.543990520371, 10177.389356638625, 1695.5337282247358, 1750.9212085456186, 1763.7178051511696, 1791.0507431061558, 1813.1659436659152, 101716.49141754318, 104373.47813260886, 106885.46557267164, 108296.0, 110078.44960775145, 11222.382768947624, 11226.045786108109, 11321.377324247245, 11443.713907152222, 11502.964733174054, 13453.260070696206, 13502.594922152352, 13524.391402386917, 13546.525871594644, 13558.89837075255, 8502.574871256413, 8507.532085735344, 8570.442921210102, 8599.871001934976, 8658.78353041179, 8434.831303373898, 8608.612612432456, 8621.870671939925, 8696.956515217384, 8704.260137888225, 4428.82284708608, 4469.754163521037, 4481.305397663367, 4493.842715504941, 4518.864434066983, 1833.8074502177346, 1899.629572233429, 1910.703840904662, 1952.47283233529, 1953.326102494637, 900.8243392538392, 950.7908260182749, 955.6511873166244, 996.5814357969671, 1041.1618646989095, 16720.03659652337, 17006.149692515326, 17866.91066544659, 19752.3086691968, 19840.90079549593, 925.2690374603987, 950.8288508068614, 954.2556805691572, 960.1982344742079, 971.7862070344513, 9259.259259259243, 10682.252242343116, 11050.115990720724, 11053.944730276458, 11077.833832492519, 588072.0, 590845.0457747683, 622486.0, 635394.0, 637686.0, 80880.59559702165, 108558.0, 109322.45338773256, 109789.45105274582, 122467.77532224741, 989.8515222716507, 1004.4776716107438, 1025.825609646362, 1069.2141276162015, 1072.4423299884018, 18110.90944545269, 18156.636867262318, 18297.0, 18320.633587327913, 18433.63132737311, 46211.76894115508, 46669.53330466788, 46819.0, 48029.279560807314, 50653.49346506635, 69367.30632693609, 72011.27988720046, 73745.63127184544, 74221.25778742143, 74378.25621743713, 6282.748690052346, 6449.516286278454, 7379.446541509301, 7563.243675632392, 7985.321247694011, 8641.740747777576, 10378.377297362182, 12368.257904525757, 12398.876011240132, 12490.188137771016, 10328.380297182193, 10386.636467723594, 10597.62908298206, 10673.199510036624, 10731.624393146203, 10354.792904142025, 10372.325798823053, 10484.842727358942, 10717.303375280582, 10739.94630026876, 10418.583256669648, 10748.623798167027, 11014.559417623526, 11041.668749937515, 11057.723556911142, 7658.195889431529, 7761.262680045386, 7768.223177682186, 7770.572618506037, 7918.643661035152, 10329.225308101772, 10622.415767132881, 10846.783064338826, 10853.186011049045, 10881.401522916316], "unit": "score", "name": "jquery.html", "value": 9221.58215908523}, {"lowerIsBetter": false, "replicates": [1606.9437569685062, 1628.6986907422129, 1641.7373220284758, 1918.453240826364, 1998.6902030185327, 8069.112397636255, 8680.609372578234, 8739.431936924095, 8953.104689531052, 8981.865272020917, 6887.896681549781, 8774.385792994493, 8889.02220755718, 8889.155530224634, 8907.68823091192, 2419.3104965084954, 2436.658867758515, 2436.683231179953, 2440.7803297703203, 2449.069353645612, 2447.5104979004273, 2470.209532949457, 2502.724700282967, 2505.8747062646885, 2510.0085466240826, 2476.702795664523, 2480.3675062858947, 2494.301595553248, 2505.6617356656893, 2507.3731567108225, 2212.78296936685, 2393.9760602393926, 2500.1249562653106, 2504.887280072401, 2514.6982362116482, 2467.099508679337, 2468.1731619907355, 2508.3478295643263, 2510.7112682041616, 2515.408878913454, 8869.955650221773, 8871.689490867853, 8878.156575125353, 8893.28853691703, 8912.287017038621, 5394.271773310592, 5554.805716770914, 5593.636413633101, 5599.188117722907, 5649.265595472562, 3601.7118630509494, 3706.388445906422, 3757.5490941087246, 3768.8492460301554, 3770.09517715749, 1040.0743338428804, 1054.5570860238718, 1056.4506456642503, 1064.4092528646597, 1066.6053560182704, 11331.526901502752, 11931.880681193164, 12023.03815694751, 12070.758584828254, 12104.6368608941, 4441.977790111094, 4963.31312608031, 5041.521055499722, 5045.344105266292, 5068.746562671851, 10243.282970192164, 10258.538365773558, 10259.974002599829, 10261.589536418609, 10279.486025698685, 5537.1140617501005, 5570.2480165177185, 5572.247746554244, 5576.191452239403, 5601.187827764951, 4400.691951563424, 4892.657513973988, 5018.573421259234, 5045.621578381636, 5089.694618322913, 3967.8809635710977, 4036.919261614751, 4045.7774822384463, 4049.615286547832, 4093.099518106012, 1319.4985905355904, 1348.440397235156, 1349.925754083535, 1355.2884735513935, 1372.4715984346099, 1160.9013233875046, 1333.3799783100906, 1379.1931719943746, 1394.6443656867434, 1401.2923473645744, 8192.426530142833, 8303.916960830315, 8309.169083091763, 8355.289800366916, 8367.205115514016, 508.1336321571711, 511.16934980656436, 515.51541550942, 520.591335801394, 526.3631006482123, 6311.715972781236, 6393.9360606394275, 6395.42441180296, 6414.454771344488, 6417.518686098561, 10323.432211228455, 10740.892591074145, 10807.459627018618, 10815.18886083547, 10867.184961127947, 8816.51509167002, 10069.949650251701, 10624.946875265574, 10629.946850265855, 10679.679609611569, 6763.898541521881, 8259.545724985064, 8269.875951860728, 8308.0, 8333.791655208546, 7727.459077864495, 8067.556284404414, 8157.0619378769825, 8241.464304820167, 8260.545669988209, 9341.626334946797, 9456.905430945877, 9570.0, 9585.376950498196, 9606.711798646053, 9295.86056209171, 9595.28035397334, 9638.614455421704, 9976.401415915068, 9995.100440960348, 6866.382025617719, 7301.977723118874, 7479.6634151464405, 7561.735339263099, 7639.961800190964, 7260.854782904418, 7962.681492740226, 8293.0, 8356.039055508694, 8356.997160340798, 7205.71177152929, 7314.48798584094, 7317.743878964211, 7472.178060413242, 7515.0, 6676.566023208476, 6858.353995041254, 7253.476769878384, 7256.383207427217, 7297.379722723415, 7680.155182929761, 7737.419693522896, 7760.767176984699, 7858.253465920957, 7949.443538952218, 7023.086998690138, 7093.716251349888, 7105.9289407107335, 7149.0, 7193.172785129568, 7220.350168484862, 7272.927270727437, 7277.636118194175, 7289.963550182428, 7295.270472952662], "unit": "score", "name": "mootools.html", "value": 4879.533448374483}, {"lowerIsBetter": false, "replicates": [324.17174120123093, 326.3831358731996, 330.30306054225565, 333.1654206213436, 334.0279785823253, 6054.879847228266, 6361.395667411594, 6770.96614516928, 6803.863922721549, 6830.658467076639, 6704.564203326792, 6757.1891373035305, 6765.357291057342, 6778.55939363941, 6801.149856267966, 4770.97614511927, 4832.0, 4940.3330550375595, 4955.578775804061, 4978.054169707753, 4922.360093187881, 4930.3344048553345, 4942.975285123587, 4944.332515110468, 4945.802167913297, 4864.0, 4869.610431165516, 4881.8291359802415, 4890.77991490382, 4896.534829191221, 4872.317875497415, 4887.14474966883, 4887.608991280689, 4899.0, 4940.851774446773, 4217.8312867485265, 4232.195882782262, 4246.341817018336, 4252.936205956913, 4255.14897020594, 6237.937620623781, 6506.284308726036, 6517.185351831021, 6543.214814222276, 6550.868982620321, 4674.789634466457, 5750.741216645261, 5816.331121920991, 5822.796202132905, 5841.357450680422, 5789.536837053026, 7231.168415632217, 7233.276672332725, 7255.310745479223, 7261.801802702601, 4621.74580398078, 4631.976840115812, 4651.674382793206, 4656.627469802442, 4673.228917228653, 7158.642067896636, 7519.473636845423, 7630.656620452093, 7631.54210747357, 7633.427492938052, 3793.715471339661, 4573.954260457419, 4633.258678611406, 4656.627469802408, 4685.672002959828, 4301.612854843017, 4387.946892745718, 4776.379070720784, 4799.520047995173, 4814.109389762905, 5351.598630102758, 5665.603407761417, 5720.256366672306, 5736.311642602915, 5744.856378590485, 5997.760089596454, 7231.5299505531975, 7235.638218089074, 7241.203467618558, 7281.708731650675, 1637.3368785641835, 1665.916704164787, 1667.2997341116761, 1669.0486422739166, 1672.172274723995, 1015.2030655935056, 1056.709404913655, 1059.2161800267747, 1059.6397224943555, 1083.3554035348955, 6687.364700353459, 6687.76592819249, 6718.227403848522, 6723.924172132533, 6740.528163028541, 7475.327220550176, 7493.0, 7514.135874374408, 7519.924800752032, 7567.621618919032, 6695.12963314766, 6695.330466953363, 6700.363465470772, 6731.865362692719, 6770.8645827084165, 3848.7113466490127, 3954.62431069048, 3983.6813054955533, 3988.3818008208773, 3995.880123596297, 7697.114831794415, 7741.922580774233, 7757.961210193913, 7808.180141085218, 7834.647440865175, 7671.6164191790185, 7671.731489397845, 7677.0, 7684.3084122429245, 7708.537487750753, 6783.796486105425, 7498.437617178624, 7697.461177717506, 7753.767386978399, 7783.766487005399, 7094.787156385317, 7480.0649918760155, 7495.700171993278, 7501.699932002877, 7502.812429689301, 7258.600776957107, 7293.234210408043, 7315.890261646186, 7355.632218388952, 7365.0, 6830.59016459014, 7751.844963100819, 7766.106897706836, 7770.53376797394, 7795.142534321333, 3528.8235588221, 4700.741459219776, 4705.576498115186, 4711.411073615798, 4719.457262414729, 6847.315268473113, 7424.740134095281, 7463.141738700119, 7476.962615186889, 7492.62536873165, 5810.76756929735, 7266.091738532684, 7280.490365674352, 7289.671964761493, 7302.306280903305, 5982.581219314607, 7202.89195662055, 7239.601821899846, 7246.130464344313, 7269.236730143471, 5434.456554344534, 7079.539829911039, 7094.396976257076, 7142.071530700976, 7156.821079473055, 7001.36987671112, 7243.420526357773, 7248.238934911969, 7284.890726639211, 7316.707331706885, 7025.508214424941, 7042.647867606497, 7060.752873649398, 7061.152661680426, 7100.325469080429], "unit": "score", "name": "prototype.html", "value": 5204.54137466741}, {"lowerIsBetter": false, "replicates": [684.2780866186173, 703.9683214255358, 722.8373615936415, 734.6179986407066, 784.4900814470593, 12393.318367489806, 12741.362931853417, 14859.40562377505, 15094.320755566, 15117.0, 12640.810387844189, 12860.292683902382, 13125.474981000749, 15803.604909877258, 15961.680766384665, 919.8620206968958, 936.7423958411423, 938.3103418987073, 939.5067589515525, 943.9622415103422, 714.9571025738446, 918.2883265469281, 928.470771660154, 937.3298091864316, 949.2690628216304, 973.4986481961795, 986.4574484033789, 992.6972273456593, 993.662154867345, 994.6866736977865, 948.6395169835488, 975.3416443900375, 976.4092723902008, 982.017982017982, 985.3841349156777, 721.0698199322867, 725.0900120348929, 735.0627949364549, 735.477810754365, 739.2127384335665, 15137.545873623809, 15327.770083448757, 15394.769078463833, 15414.768778468331, 15450.9227453862, 12393.256404615751, 12467.625971220878, 12548.623541293684, 12659.683507912283, 12699.0, 8812.471251724917, 9235.676751313738, 10006.899241083474, 10586.470676466146, 10595.68212953605, 3412.8566930078455, 3423.058658868806, 3465.4801779733243, 3491.5286436331025, 3529.1882866940746, 82968.0, 83864.16135838625, 83986.3202735948, 84057.57971210228, 85375.0, 7563.886541701879, 9302.116298951589, 9306.441613503212, 9364.90635093654, 9651.951740241395, 15789.131597762003, 20962.790372096082, 21348.466288342916, 21355.25256616011, 21411.46471338229, 5645.2096706461125, 6303.802277567339, 6936.895946560806, 6969.965150174216, 7505.774826755206, 3946.565877753445, 4007.238624661305, 4010.2618155060873, 4021.4571032910767, 4072.165206132736, 3125.1405863387295, 3473.7568370213844, 3507.456719043613, 3595.2449985503335, 3620.71034317254, 542.6472792684787, 615.6275453350659, 634.8190765631773, 658.9275179730225, 661.0183876942737, 480.5962991087503, 578.0462237308475, 584.7047241143196, 615.0681717198448, 625.4621025917708, 7451.478396512192, 7927.128015918244, 7978.880316795253, 7979.72070977513, 8005.759827205193, 544.9373322068013, 547.9780808767684, 556.4908109080146, 565.6916980245776, 573.1059547106527, 3616.833299224815, 3742.4760533525327, 3747.2130852521277, 3834.8155918014154, 3847.245812309823, 77691.61154194192, 78880.0, 79398.0, 79762.60118699369, 80678.0, 68519.0, 73509.0, 73732.63133684297, 74224.62887685528, 74565.0, 67026.0, 67062.66468667626, 67970.99999999901, 68141.23011389155, 68263.3173668257, 7496.7376141834775, 7518.323350898446, 7521.0, 7558.13081495613, 7749.457537972288, 49106.50893491019, 49730.751346243036, 49887.50112498829, 50357.74821126017, 50407.24389134093, 58560.70719646374, 60245.698771505864, 61725.0, 64532.0, 65342.67328663326, 9586.11071129011, 9603.855942160733, 9686.70939871805, 9854.408735475894, 9905.702828915144, 10304.845427318447, 10403.271770975958, 10425.739356516147, 10668.413237272025, 11323.490442929924, 10013.198944084601, 10318.845217321596, 10334.276600637882, 10336.0697537222, 10378.481075946022, 9843.803123937625, 10020.69937901864, 10246.487675616041, 10260.743481413025, 10439.164866810484, 9673.758156046155, 10633.713751543455, 11036.11711063129, 11492.310461372344, 11692.415379231175, 8681.871356723586, 9293.210077143518, 9497.28770342241, 9676.758081047748, 9691.854622180814, 8581.843429959928, 9590.712278631652, 9619.086186812241, 9625.51872406391, 9690.95154524223], "unit": "score", "name": "yui.html", "value": 6662.308849326683}], "name": "dromaeo_css", "value": 7503.899150885685}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 131.0, 113.0, 113.0, 127.0, 155.0, 116.0, 93.0, 164.0], "unit": "score", "name": "ai-astar", "value": 123.5}, {"lowerIsBetter": true, "replicates": [149.0, 125.0, 142.0, 154.0, 159.0, 178.0, 138.0, 122.0, 156.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [196.0, 197.0, 201.0, 180.0, 265.0, 280.0, 241.0, 203.0, 201.0, 202.0], "unit": "score", "name": "audio-dft", "value": 216.6}, {"lowerIsBetter": true, "replicates": [61.0, 74.0, 57.0, 61.0, 70.0, 99.0, 142.0, 75.0, 56.0, 61.0], "unit": "score", "name": "audio-fft", "value": 75.6}, {"lowerIsBetter": true, "replicates": [87.0, 63.0, 158.0, 114.0, 124.0, 120.0, 125.0, 81.0, 81.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [92.0, 89.0, 106.0, 131.0, 112.0, 88.0, 93.0, 111.0, 123.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 105.3}, {"lowerIsBetter": true, "replicates": [108.0, 96.0, 96.0, 106.0, 108.0, 153.0, 152.0, 97.0, 96.0, 104.0], "unit": "score", "name": "imaging-darkroom", "value": 111.6}, {"lowerIsBetter": true, "replicates": [90.0, 94.0, 94.0, 91.0, 100.0, 110.0, 115.0, 76.0, 152.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 101.2}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 55.0, 56.0, 55.0, 58.0, 57.0, 75.0, 80.0, 86.0], "unit": "score", "name": "json-parse-financial", "value": 63.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 73.0, 72.0, 66.0, 66.0, 66.0, 65.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 89.0, 89.0, 84.0, 84.0, 87.0, 87.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [132.0, 122.0, 145.0, 132.0, 142.0, 135.0, 126.0, 130.0, 123.0, 141.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.8}, {"lowerIsBetter": true, "replicates": [144.0, 143.0, 143.0, 142.0, 143.0, 148.0, 145.0, 142.0, 142.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 67.0, 69.0, 69.0, 73.0, 95.0, 99.0, 102.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.1}], "name": "kraken", "value": 1555.2}]} 05:52:38 INFO - Return code: 0 05:52:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:52:38 ERROR - # TBPL SUCCESS # 05:52:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:38 INFO - 2016-03-12 05:52:38.995 screenresolution[1692:10961] starting screenresolution argv=screenresolution get 05:52:38 INFO - 2016-03-12 05:52:38.997 screenresolution[1692:10961] Display 0: 1600x1200x32@60 05:52:39 INFO - 2016-03-12 05:52:39.003 screenresolution[1693:10964] starting screenresolution argv=screenresolution list 05:52:39 INFO - Available Modes on Display 0 05:52:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:39 INFO - Intel Iris: 05:52:39 INFO - Chipset Model: Intel Iris 05:52:39 INFO - Type: GPU 05:52:39 INFO - Bus: Built-In 05:52:39 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:39 INFO - Vendor: Intel (0x8086) 05:52:39 INFO - Device ID: 0x0a2e 05:52:39 INFO - Revision ID: 0x0009 05:52:39 INFO - Displays: 05:52:39 INFO - Display: 05:52:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:39 INFO - Display Serial Number: 1600x1200 60 05:52:39 INFO - Main Display: Yes 05:52:39 INFO - Mirror: Off 05:52:39 INFO - Online: Yes 05:52:39 INFO - Rotation: Supported 05:52:39 INFO - Return code: 0 05:52:39 INFO - Running post-action listener: _resource_record_post_action 05:52:39 INFO - Running post-run listener: _resource_record_post_run 05:52:40 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 34196992; Write bytes: 707171328; Read time: 354; Write time: 2042 05:52:40 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391250432; Write bytes: 385648640; Read time: 29779; Write time: 727 05:52:40 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32423424; Write bytes: 302144512; Read time: 336; Write time: 1273 05:52:40 INFO - Running post-run listener: _upload_blobber_files 05:52:40 INFO - Blob upload gear active. 05:52:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:52:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:52:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:52:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:41 INFO - (blobuploader) - INFO - Done attempting. 05:52:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:52:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:42 INFO - (blobuploader) - INFO - Done attempting. 05:52:42 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:42 INFO - Return code: 0 05:52:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0400d4b0a564b46fb62117ac533247c5f4694aaf951825950c73a9de902a065fd76c624f5b635940877984684369fbdc5c52351859d60f22ee075e324aba5010", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/785e837dc6bca2735dc39f5a16a3956c4c26a138dab258c7541f7e1018551af3586ef2fbd88ae2d390ddcc0e206eafcc1da5f80e2778117848cc8ad57d4d815f"} 05:52:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:42 INFO - Contents: 05:52:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0400d4b0a564b46fb62117ac533247c5f4694aaf951825950c73a9de902a065fd76c624f5b635940877984684369fbdc5c52351859d60f22ee075e324aba5010", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/785e837dc6bca2735dc39f5a16a3956c4c26a138dab258c7541f7e1018551af3586ef2fbd88ae2d390ddcc0e206eafcc1da5f80e2778117848cc8ad57d4d815f"} 05:52:42 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:42 INFO - Copying logs to upload dir... 05:52:42 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1355.260273 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 35 secs) (at 2016-03-12 05:52:42.560070) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 05:52:42.563355) ========= 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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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/0400d4b0a564b46fb62117ac533247c5f4694aaf951825950c73a9de902a065fd76c624f5b635940877984684369fbdc5c52351859d60f22ee075e324aba5010", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/785e837dc6bca2735dc39f5a16a3956c4c26a138dab258c7541f7e1018551af3586ef2fbd88ae2d390ddcc0e206eafcc1da5f80e2778117848cc8ad57d4d815f"} build_url:https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/J37zCF64TqGn6FAprxvjFg/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/0400d4b0a564b46fb62117ac533247c5f4694aaf951825950c73a9de902a065fd76c624f5b635940877984684369fbdc5c52351859d60f22ee075e324aba5010", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/785e837dc6bca2735dc39f5a16a3956c4c26a138dab258c7541f7e1018551af3586ef2fbd88ae2d390ddcc0e206eafcc1da5f80e2778117848cc8ad57d4d815f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 05:52:42.591803) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:52:42.592139) ========= 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.jfkpOKo9Sq/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.ut6cIODPyR/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005242 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 05:52:42.641836) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 05:52:42.642159) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 05:52:42.642554) ========= ========= Total master_lag: 0.71 =========