builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0172 starttime: 1457980916.93 results: success (0) buildid: 20160314103428 builduid: 51713045d2d34761809001124717e515 revision: 98dbd52b1b67eb85f4605b027ead33a3a847ce9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:56.927291) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:56.927732) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:56.928030) ========= 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.YvkxD5yiaG/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.GCisalq8Ni/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005466 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:56.955253) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:56.955519) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:56.977529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:56.977800) ========= 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.YvkxD5yiaG/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.GCisalq8Ni/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005500 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.025660) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.029008) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.029363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.029651) ========= 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.YvkxD5yiaG/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.GCisalq8Ni/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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-14 11:41:57-- 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% 12.2M=0.001s 2016-03-14 11:41:57 (12.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163845 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.209717) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.213038) ========= 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.YvkxD5yiaG/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.GCisalq8Ni/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.025702 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:57.262522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 11:41:57.265879) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 98dbd52b1b67eb85f4605b027ead33a3a847ce9a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 98dbd52b1b67eb85f4605b027ead33a3a847ce9a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YvkxD5yiaG/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.GCisalq8Ni/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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-14 11:41:57,339 truncating revision to first 12 chars 2016-03-14 11:41:57,339 Setting DEBUG logging. 2016-03-14 11:41:57,339 attempt 1/10 2016-03-14 11:41:57,339 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/98dbd52b1b67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 11:41:58,301 unpacking tar archive at: mozilla-aurora-98dbd52b1b67/testing/mozharness/ program finished with exit code 0 elapsedTime=1.207078 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 11:41:58.492859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:58.493229) ========= echo 98dbd52b1b67eb85f4605b027ead33a3a847ce9a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'98dbd52b1b67eb85f4605b027ead33a3a847ce9a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YvkxD5yiaG/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.GCisalq8Ni/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 98dbd52b1b67eb85f4605b027ead33a3a847ce9a program finished with exit code 0 elapsedTime=0.005504 script_repo_revision: '98dbd52b1b67eb85f4605b027ead33a3a847ce9a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:58.545605) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:58.545933) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 11:41:58.559886) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 35 secs) (at 2016-03-14 11:41:58.560216) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YvkxD5yiaG/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.GCisalq8Ni/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 11:41:58 INFO - MultiFileLogger online at 20160314 11:41:58 in /builds/slave/test 11:41:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:41:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:41:58 INFO - {'append_to_log': False, 11:41:58 INFO - 'base_work_dir': '/builds/slave/test', 11:41:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:41:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:41:58 INFO - 'branch': 'Mozilla-Aurora', 11:41:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:41:58 INFO - 'config_files': ('talos/mac_config.py',), 11:41:58 INFO - 'default_actions': ('clobber', 11:41:58 INFO - 'read-buildbot-config', 11:41:58 INFO - 'download-and-extract', 11:41:58 INFO - 'populate-webroot', 11:41:58 INFO - 'create-virtualenv', 11:41:58 INFO - 'install', 11:41:58 INFO - 'run-tests'), 11:41:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:41:58 INFO - 'download_minidump_stackwalk': True, 11:41:58 INFO - 'download_symbols': 'ondemand', 11:41:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:41:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:41:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:41:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:41:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:41:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:41:58 INFO - 'installer_path': 'installer.exe', 11:41:58 INFO - 'log_level': 'info', 11:41:58 INFO - 'log_name': 'talos', 11:41:58 INFO - 'log_to_console': True, 11:41:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:41:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:41:58 INFO - 'opt_config_files': (), 11:41:58 INFO - 'pip_index': False, 11:41:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:41:58 INFO - 'cmd': ('bash', 11:41:58 INFO - '-c', 11:41:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:41:58 INFO - 'enabled': True, 11:41:58 INFO - 'halt_on_failure': False, 11:41:58 INFO - 'name': 'check_screen_resolution'},), 11:41:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:41:58 INFO - 'cmd': ('bash', 11:41:58 INFO - '-c', 11:41:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:41:58 INFO - 'enabled': True, 11:41:58 INFO - 'halt_on_failure': False, 11:41:58 INFO - 'name': 'check_screen_resolution'},), 11:41:58 INFO - 'run_cmd_checks_enabled': True, 11:41:58 INFO - 'sps_profile': False, 11:41:58 INFO - 'sps_profile_interval': 0, 11:41:58 INFO - 'suite': 'dromaeojs-e10s', 11:41:58 INFO - 'system_bits': '32', 11:41:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:41:58 INFO - 'title': 't-yosemite-r7-0172', 11:41:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:41:58 INFO - 'use_talos_json': True, 11:41:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:41:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:41:58 INFO - 'work_dir': 'build'} 11:41:58 INFO - ##### 11:41:58 INFO - ##### Running clobber step. 11:41:58 INFO - ##### 11:41:58 INFO - Running pre-action listener: _resource_record_pre_action 11:41:58 INFO - Running main action method: clobber 11:41:58 INFO - rmtree: /builds/slave/test/build 11:41:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:42:00 INFO - Running post-action listener: _resource_record_post_action 11:42:00 INFO - ##### 11:42:00 INFO - ##### Running read-buildbot-config step. 11:42:00 INFO - ##### 11:42:00 INFO - Running pre-action listener: _resource_record_pre_action 11:42:00 INFO - Running main action method: read_buildbot_config 11:42:00 INFO - Using buildbot properties: 11:42:00 INFO - { 11:42:00 INFO - "project": "", 11:42:00 INFO - "product": "firefox", 11:42:00 INFO - "script_repo_revision": "production", 11:42:00 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 11:42:00 INFO - "repository": "", 11:42:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 11:42:00 INFO - "buildid": "20160314103428", 11:42:00 INFO - "pgo_build": "False", 11:42:00 INFO - "basedir": "/builds/slave/test", 11:42:00 INFO - "buildnumber": 194, 11:42:00 INFO - "slavename": "t-yosemite-r7-0172", 11:42:00 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:42:00 INFO - "platform": "yosemite_r7", 11:42:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:42:00 INFO - "branch": "mozilla-aurora", 11:42:00 INFO - "repo_path": "releases/mozilla-aurora", 11:42:00 INFO - "revision": "98dbd52b1b67eb85f4605b027ead33a3a847ce9a", 11:42:00 INFO - "stage_platform": "macosx64", 11:42:00 INFO - "builduid": "51713045d2d34761809001124717e515", 11:42:00 INFO - "slavebuilddir": "test" 11:42:00 INFO - } 11:42:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 11:42:00 INFO - Running post-action listener: _resource_record_post_action 11:42:00 INFO - ##### 11:42:00 INFO - ##### Running download-and-extract step. 11:42:00 INFO - ##### 11:42:00 INFO - Running pre-action listener: _resource_record_pre_action 11:42:00 INFO - Running main action method: download_and_extract 11:42:00 INFO - mkdir: /builds/slave/test/build/tests 11:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:00 INFO - https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:42:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 11:42:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 11:42:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 11:42:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 11:42:01 INFO - Downloaded 1277 bytes. 11:42:01 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 11:42:01 INFO - Using the following test package requirements: 11:42:01 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:42:01 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:01 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 11:42:01 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:01 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 11:42:01 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:01 INFO - u'jsshell-mac.zip'], 11:42:01 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:01 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 11:42:01 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:42:01 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:01 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 11:42:01 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:01 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 11:42:01 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:01 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 11:42:01 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 11:42:01 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 11:42:01 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 11:42:01 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:42:01 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')]} 11:42:01 INFO - https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:42:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:42:03 INFO - Downloaded 17864916 bytes. 11:42:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:42:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:42:06 INFO - Return code: 0 11:42:06 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:42: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')]} 11:42:06 INFO - https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:42:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 11:42:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:42:07 INFO - Downloaded 17864916 bytes. 11:42:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:42:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:42:11 INFO - Return code: 0 11:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:11 INFO - https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:42:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:42:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:42:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 11:42:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:42:12 INFO - Downloaded 10845161 bytes. 11:42:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:42:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:42:12 INFO - Return code: 0 11:42:12 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')]} 11:42:12 INFO - https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 11:42:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:42:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:42:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 11:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 11:42:17 INFO - Downloaded 115007077 bytes. 11:42:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:42:17 INFO - mkdir: /builds/slave/test/properties 11:42:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:42:17 INFO - Writing to file /builds/slave/test/properties/build_url 11:42:17 INFO - Contents: 11:42:17 INFO - build_url:https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 11:42:18 INFO - Running post-action listener: _resource_record_post_action 11:42:18 INFO - Running post-action listener: set_extra_try_arguments 11:42:18 INFO - ##### 11:42:18 INFO - ##### Running populate-webroot step. 11:42:18 INFO - ##### 11:42:18 INFO - Running pre-action listener: _resource_record_pre_action 11:42:18 INFO - Running main action method: populate_webroot 11:42:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:42:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:42:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:42:18 INFO - '--tppagecycles', 11:42:18 INFO - '7'], 11:42:18 INFO - 'tests': ['tsvgm']}}, 11:42:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:42:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:42:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:42:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:42:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'tests': ['damp', 'tps']}, 11:42:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['damp', 'tps']}, 11:42:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:42:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:42:18 INFO - 'other': {'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore', 11:42:18 INFO - 'tabpaint']}, 11:42:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore', 11:42:18 INFO - 'tabpaint']}, 11:42:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore', 11:42:18 INFO - 'tabpaint']}, 11:42:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore', 11:42:18 INFO - 'tabpaint']}, 11:42:18 INFO - 'other_l64': {'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore', 11:42:18 INFO - 'tabpaint']}, 11:42:18 INFO - 'other_nol64': {'tests': ['a11yr', 11:42:18 INFO - 'ts_paint', 11:42:18 INFO - 'tpaint', 11:42:18 INFO - 'sessionrestore', 11:42:18 INFO - 'sessionrestore_no_auto_restore', 11:42:18 INFO - 'tabpaint']}, 11:42:18 INFO - 'svgr': {'tests': ['tsvgx', 11:42:18 INFO - 'tsvgr_opacity', 11:42:18 INFO - 'tart', 11:42:18 INFO - 'tscrollx', 11:42:18 INFO - 'cart']}, 11:42:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['tsvgx', 11:42:18 INFO - 'tsvgr_opacity', 11:42:18 INFO - 'tart', 11:42:18 INFO - 'tscrollx', 11:42:18 INFO - 'cart']}, 11:42:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'tests': ['tp5o']}, 11:42:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'talos_options': ['--e10s'], 11:42:18 INFO - 'tests': ['tp5o']}, 11:42:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'talos_options': ['--xperf_path', 11:42:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:18 INFO - 'tests': ['tp5n']}, 11:42:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:18 INFO - 'talos_options': ['--e10s', 11:42:18 INFO - '--xperf_path', 11:42:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:18 INFO - 'tests': ['tp5n']}}, 11:42:18 INFO - 'talos.zip': {'path': '', 11:42:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:42:18 INFO - Running post-action listener: _resource_record_post_action 11:42:18 INFO - ##### 11:42:18 INFO - ##### Running create-virtualenv step. 11:42:18 INFO - ##### 11:42:18 INFO - Running pre-action listener: _resource_record_pre_action 11:42:18 INFO - Running main action method: create_virtualenv 11:42:18 INFO - Creating virtualenv /builds/slave/test/build/venv 11:42:18 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 11:42:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:42:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:42:18 INFO - Using real prefix '/tools/python27' 11:42:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:42:19 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:22 INFO - Installing pip.................done. 11:42:22 INFO - Return code: 0 11:42:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:42: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')]} 11:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42: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')]} 11:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:22 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 0x10a4d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc9d6a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a377d30>, '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 0x10a1dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a36eb20>, '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.YvkxD5yiaG/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.GCisalq8Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 11:42:22 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 11:42:22 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 11:42:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvkxD5yiaG/Render', 11:42:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:22 INFO - 'HOME': '/Users/cltbld', 11:42:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:22 INFO - 'LOGNAME': 'cltbld', 11:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:22 INFO - 'MOZ_NO_REMOTE': '1', 11:42:22 INFO - 'NO_EM_RESTART': '1', 11:42:22 INFO - 'PAGER': '/bin/cat', 11:42:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:22 INFO - 'PWD': '/builds/slave/test', 11:42:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:22 INFO - 'SHELL': '/bin/bash', 11:42:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCisalq8Ni/Listeners', 11:42:22 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 11:42:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:22 INFO - 'USER': 'cltbld', 11:42:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:22 INFO - 'XPC_FLAGS': '0x0', 11:42:22 INFO - 'XPC_SERVICE_NAME': '0', 11:42:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:22 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 11:42:22 INFO - Cleaning up... 11:42:22 INFO - Return code: 0 11:42:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:42: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')]} 11:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42: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')]} 11:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:22 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 0x10a4d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc9d6a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a377d30>, '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 0x10a1dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a36eb20>, '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.YvkxD5yiaG/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.GCisalq8Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 11:42:22 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 11:42:22 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 11:42:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvkxD5yiaG/Render', 11:42:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:22 INFO - 'HOME': '/Users/cltbld', 11:42:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:22 INFO - 'LOGNAME': 'cltbld', 11:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:22 INFO - 'MOZ_NO_REMOTE': '1', 11:42:22 INFO - 'NO_EM_RESTART': '1', 11:42:22 INFO - 'PAGER': '/bin/cat', 11:42:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:22 INFO - 'PWD': '/builds/slave/test', 11:42:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:22 INFO - 'SHELL': '/bin/bash', 11:42:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCisalq8Ni/Listeners', 11:42:22 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 11:42:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:22 INFO - 'USER': 'cltbld', 11:42:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:22 INFO - 'XPC_FLAGS': '0x0', 11:42:22 INFO - 'XPC_SERVICE_NAME': '0', 11:42:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:22 INFO - Downloading/unpacking psutil>=0.7.1 11:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:42:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:25 INFO - Installing collected packages: psutil 11:42:25 INFO - Running setup.py install for psutil 11:42:25 INFO - building 'psutil._psutil_osx' extension 11:42:25 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 11:42:25 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 11:42:26 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 11:42:26 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 11:42:26 INFO - building 'psutil._psutil_posix' extension 11:42:26 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 11:42:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:42:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:42:26 INFO - ^ 11:42:26 INFO - 1 warning generated. 11:42:26 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 11:42:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:26 INFO - Successfully installed psutil 11:42:26 INFO - Cleaning up... 11:42:26 INFO - Return code: 0 11:42:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:26 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 0x10a4d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc9d6a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a377d30>, '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 0x10a1dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a36eb20>, '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.YvkxD5yiaG/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.GCisalq8Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 11:42:26 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 11:42:26 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 11:42:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvkxD5yiaG/Render', 11:42:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:26 INFO - 'HOME': '/Users/cltbld', 11:42:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:26 INFO - 'LOGNAME': 'cltbld', 11:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:26 INFO - 'MOZ_NO_REMOTE': '1', 11:42:26 INFO - 'NO_EM_RESTART': '1', 11:42:26 INFO - 'PAGER': '/bin/cat', 11:42:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:26 INFO - 'PWD': '/builds/slave/test', 11:42:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:26 INFO - 'SHELL': '/bin/bash', 11:42:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCisalq8Ni/Listeners', 11:42:26 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 11:42:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:26 INFO - 'USER': 'cltbld', 11:42:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:26 INFO - 'XPC_FLAGS': '0x0', 11:42:26 INFO - 'XPC_SERVICE_NAME': '0', 11:42:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:42:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:42:29 INFO - Installing collected packages: mozsystemmonitor 11:42:29 INFO - Running setup.py install for mozsystemmonitor 11:42:29 INFO - Successfully installed mozsystemmonitor 11:42:29 INFO - Cleaning up... 11:42:29 INFO - Return code: 0 11:42:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:42:29 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')]} 11:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:29 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')]} 11:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:29 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 0x10a4d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc9d6a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a377d30>, '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 0x10a1dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a36eb20>, '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.YvkxD5yiaG/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.GCisalq8Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 11:42:29 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 11:42:29 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 11:42:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvkxD5yiaG/Render', 11:42:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:29 INFO - 'HOME': '/Users/cltbld', 11:42:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:29 INFO - 'LOGNAME': 'cltbld', 11:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:29 INFO - 'MOZ_NO_REMOTE': '1', 11:42:29 INFO - 'NO_EM_RESTART': '1', 11:42:29 INFO - 'PAGER': '/bin/cat', 11:42:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:29 INFO - 'PWD': '/builds/slave/test', 11:42:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:29 INFO - 'SHELL': '/bin/bash', 11:42:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCisalq8Ni/Listeners', 11:42:29 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 11:42:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:29 INFO - 'USER': 'cltbld', 11:42:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:29 INFO - 'XPC_FLAGS': '0x0', 11:42:29 INFO - 'XPC_SERVICE_NAME': '0', 11:42:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:29 INFO - Downloading/unpacking blobuploader==1.2.4 11:42:29 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 11:42:29 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 11:42:29 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 11:42:29 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 11:42:29 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 11:42:29 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 11:42:31 INFO - Downloading blobuploader-1.2.4.tar.gz 11:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:42:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:42:32 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 11:42:32 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 11:42:32 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 11:42:32 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 11:42:32 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 11:42:32 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 11:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:42:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:42:32 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 11:42:32 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 11:42:32 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 11:42:32 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 11:42:32 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 11:42:32 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 11:42:33 INFO - Downloading docopt-0.6.1.tar.gz 11:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:42:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:42:33 INFO - Running setup.py install for blobuploader 11:42:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:42:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:42:33 INFO - Running setup.py install for requests 11:42:33 INFO - Running setup.py install for docopt 11:42:33 INFO - Successfully installed blobuploader requests docopt 11:42:33 INFO - Cleaning up... 11:42:34 INFO - Return code: 0 11:42:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:34 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 0x10a4d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc9d6a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a377d30>, '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 0x10a1dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a36eb20>, '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.YvkxD5yiaG/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.GCisalq8Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 11:42:34 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 11:42:34 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 11:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvkxD5yiaG/Render', 11:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:34 INFO - 'HOME': '/Users/cltbld', 11:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:34 INFO - 'LOGNAME': 'cltbld', 11:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:34 INFO - 'MOZ_NO_REMOTE': '1', 11:42:34 INFO - 'NO_EM_RESTART': '1', 11:42:34 INFO - 'PAGER': '/bin/cat', 11:42:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:34 INFO - 'PWD': '/builds/slave/test', 11:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:34 INFO - 'SHELL': '/bin/bash', 11:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCisalq8Ni/Listeners', 11:42:34 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 11:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:34 INFO - 'USER': 'cltbld', 11:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:34 INFO - 'XPC_FLAGS': '0x0', 11:42:34 INFO - 'XPC_SERVICE_NAME': '0', 11:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:34 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-wwnlVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:34 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-vFtb1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:34 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-T3lm6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:34 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-36Zfti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:34 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ApB9Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:34 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ecDpWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:34 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-BiMsQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:35 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-LCYyfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:35 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-co2Po6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:35 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-QeCFuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:35 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-7dF93c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:35 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-BDwMf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:35 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-ofP0sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:35 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-rl3CJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:35 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-K677e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:35 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-oiMCDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:36 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-gLM69C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:42:36 INFO - Running setup.py install for manifestparser 11:42:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:42:36 INFO - Running setup.py install for mozcrash 11:42:36 INFO - Running setup.py install for mozdebug 11:42:36 INFO - Running setup.py install for mozdevice 11:42:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:42:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:42:36 INFO - Running setup.py install for mozfile 11:42:36 INFO - Running setup.py install for mozhttpd 11:42:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozinfo 11:42:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozInstall 11:42:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozleak 11:42:37 INFO - Running setup.py install for mozlog 11:42:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for moznetwork 11:42:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozprocess 11:42:37 INFO - Running setup.py install for mozprofile 11:42:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozrunner 11:42:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozscreenshot 11:42:38 INFO - Running setup.py install for moztest 11:42:38 INFO - Running setup.py install for mozversion 11:42:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:42:38 INFO - Cleaning up... 11:42:38 INFO - Return code: 0 11:42:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:38 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 0x10a4d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc9d6a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a377d30>, '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 0x10a1dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a36eb20>, '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.YvkxD5yiaG/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.GCisalq8Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 11:42:38 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 11:42:38 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 11:42:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvkxD5yiaG/Render', 11:42:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:38 INFO - 'HOME': '/Users/cltbld', 11:42:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:38 INFO - 'LOGNAME': 'cltbld', 11:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:38 INFO - 'MOZ_NO_REMOTE': '1', 11:42:38 INFO - 'NO_EM_RESTART': '1', 11:42:38 INFO - 'PAGER': '/bin/cat', 11:42:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:38 INFO - 'PWD': '/builds/slave/test', 11:42:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:38 INFO - 'SHELL': '/bin/bash', 11:42:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCisalq8Ni/Listeners', 11:42:38 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 11:42:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:38 INFO - 'USER': 'cltbld', 11:42:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:38 INFO - 'XPC_FLAGS': '0x0', 11:42:38 INFO - 'XPC_SERVICE_NAME': '0', 11:42:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-0H4K6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-iGXERH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-cZqTCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-cheoS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-IoOMMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Qu0P2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-xkN0DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-3Wp3lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-itLbvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:39 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Ufgspt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:40 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-fuV0zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:40 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-JJpMYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:40 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-RjKClf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:40 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-nPmjwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:40 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-Re3JVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:40 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-bELiXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:40 INFO - Running setup.py (path:/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/pip-U61QLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:40 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)) 11:42:40 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)) 11:42:40 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)) 11:42:40 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)) 11:42:40 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)) 11:42:40 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)) 11:42:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42:40 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 11:42:40 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 11:42:40 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 11:42:40 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 11:42:40 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 11:42:40 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 11:42:43 INFO - Downloading blessings-1.6.tar.gz 11:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:42:43 INFO - Installing collected packages: blessings 11:42:43 INFO - Running setup.py install for blessings 11:42:43 INFO - Successfully installed blessings 11:42:43 INFO - Cleaning up... 11:42:43 INFO - Return code: 0 11:42:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:43 INFO - Reading from file tmpfile_stdout 11:42:43 INFO - Current package versions: 11:42:43 INFO - blessings == 1.6 11:42:43 INFO - blobuploader == 1.2.4 11:42:43 INFO - docopt == 0.6.1 11:42:43 INFO - manifestparser == 1.1 11:42:43 INFO - mozInstall == 1.12 11:42:43 INFO - mozcrash == 0.17 11:42:43 INFO - mozdebug == 0.1 11:42:43 INFO - mozdevice == 0.48 11:42:43 INFO - mozfile == 1.2 11:42:43 INFO - mozhttpd == 0.7 11:42:43 INFO - mozinfo == 0.9 11:42:43 INFO - mozleak == 0.1 11:42:43 INFO - mozlog == 3.1 11:42:43 INFO - moznetwork == 0.27 11:42:43 INFO - mozprocess == 0.22 11:42:43 INFO - mozprofile == 0.28 11:42:43 INFO - mozrunner == 6.11 11:42:43 INFO - mozscreenshot == 0.1 11:42:43 INFO - mozsystemmonitor == 0.0 11:42:43 INFO - moztest == 0.7 11:42:43 INFO - mozversion == 1.4 11:42:43 INFO - psutil == 3.1.1 11:42:43 INFO - requests == 1.2.3 11:42:43 INFO - wsgiref == 0.1.2 11:42:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:43 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 0x10a4d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc9d6a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a377d30>, '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 0x10a1dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a36eb20>, '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.YvkxD5yiaG/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.GCisalq8Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 11:42:43 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 11:42:43 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 11:42:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvkxD5yiaG/Render', 11:42:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:43 INFO - 'HOME': '/Users/cltbld', 11:42:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:43 INFO - 'LOGNAME': 'cltbld', 11:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:43 INFO - 'MOZ_NO_REMOTE': '1', 11:42:43 INFO - 'NO_EM_RESTART': '1', 11:42:43 INFO - 'PAGER': '/bin/cat', 11:42:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:43 INFO - 'PWD': '/builds/slave/test', 11:42:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:43 INFO - 'SHELL': '/bin/bash', 11:42:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCisalq8Ni/Listeners', 11:42:43 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 11:42:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:43 INFO - 'USER': 'cltbld', 11:42:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:43 INFO - 'XPC_FLAGS': '0x0', 11:42:43 INFO - 'XPC_SERVICE_NAME': '0', 11:42:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:44 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)) 11:42:44 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)) 11:42:44 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)) 11:42:44 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)) 11:42:44 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)) 11:42:44 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)) 11:42:44 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)) 11:42:44 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)) 11:42:44 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)) 11:42:44 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)) 11:42:44 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)) 11:42:44 INFO - Cleaning up... 11:42:44 INFO - Return code: 0 11:42:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:42:44 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')]} 11:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:44 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')]} 11:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:44 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 0x10a4d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc9d6a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a377d30>, '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 0x10a1dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a36eb20>, '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.YvkxD5yiaG/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.GCisalq8Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 11:42:44 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 11:42:44 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 11:42:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvkxD5yiaG/Render', 11:42:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:44 INFO - 'HOME': '/Users/cltbld', 11:42:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:44 INFO - 'LOGNAME': 'cltbld', 11:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:44 INFO - 'MOZ_NO_REMOTE': '1', 11:42:44 INFO - 'NO_EM_RESTART': '1', 11:42:44 INFO - 'PAGER': '/bin/cat', 11:42:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:44 INFO - 'PWD': '/builds/slave/test', 11:42:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:44 INFO - 'SHELL': '/bin/bash', 11:42:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCisalq8Ni/Listeners', 11:42:44 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 11:42:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:44 INFO - 'USER': 'cltbld', 11:42:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:44 INFO - 'XPC_FLAGS': '0x0', 11:42:44 INFO - 'XPC_SERVICE_NAME': '0', 11:42:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:44 INFO - Downloading/unpacking jsonschema 11:42:44 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 11:42:44 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 11:42:44 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 11:42:44 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 11:42:44 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 11:42:44 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 11:42:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:42:46 INFO - Downloading/unpacking functools32 (from jsonschema) 11:42:46 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 11:42:46 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 11:42:46 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 11:42:46 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 11:42:46 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 11:42:46 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 11:42:46 INFO - Downloading functools32-3.2.3-2.tar.gz 11:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:42:47 INFO - warning: no files found matching '*.txt' 11:42:47 INFO - no previously-included directories found matching 'build' 11:42:47 INFO - no previously-included directories found matching 'dist' 11:42:47 INFO - no previously-included directories found matching '.git*' 11:42:47 INFO - Installing collected packages: jsonschema, functools32 11:42:47 INFO - Running setup.py install for functools32 11:42:47 INFO - warning: no files found matching '*.txt' 11:42:47 INFO - no previously-included directories found matching 'build' 11:42:47 INFO - no previously-included directories found matching 'dist' 11:42:47 INFO - no previously-included directories found matching '.git*' 11:42:47 INFO - Successfully installed jsonschema functools32 11:42:47 INFO - Cleaning up... 11:42:47 INFO - Return code: 0 11:42:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:42:47 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')]} 11:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:47 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')]} 11:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:47 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 0x10a4d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbfc9d6a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a377d30>, '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 0x10a1dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a36eb20>, '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.YvkxD5yiaG/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.GCisalq8Ni/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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 11:42:47 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 11:42:47 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 11:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvkxD5yiaG/Render', 11:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:47 INFO - 'HOME': '/Users/cltbld', 11:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:47 INFO - 'LOGNAME': 'cltbld', 11:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:47 INFO - 'MOZ_NO_REMOTE': '1', 11:42:47 INFO - 'NO_EM_RESTART': '1', 11:42:47 INFO - 'PAGER': '/bin/cat', 11:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:47 INFO - 'PWD': '/builds/slave/test', 11:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:47 INFO - 'SHELL': '/bin/bash', 11:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCisalq8Ni/Listeners', 11:42:47 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 11:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:47 INFO - 'USER': 'cltbld', 11:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:47 INFO - 'XPC_FLAGS': '0x0', 11:42:47 INFO - 'XPC_SERVICE_NAME': '0', 11:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:47 INFO - Downloading/unpacking flake8 11:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:42:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:42:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:42:51 INFO - no previously-included directories found matching 'docs/_build' 11:42:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:42:51 INFO - Running setup.py install for pep8 11:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:42:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:42:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:42:51 INFO - no previously-included directories found matching 'docs/_build' 11:42:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:42:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:42:51 INFO - Cleaning up... 11:42:51 INFO - Return code: 0 11:42:51 INFO - Running post-action listener: _resource_record_post_action 11:42:51 INFO - Running post-action listener: _start_resource_monitoring 11:42:51 INFO - Starting resource monitoring. 11:42:51 INFO - ##### 11:42:51 INFO - ##### Running install step. 11:42:51 INFO - ##### 11:42:51 INFO - Running pre-action listener: _resource_record_pre_action 11:42:51 INFO - Running main action method: install 11:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:51 INFO - Reading from file tmpfile_stdout 11:42:51 INFO - Detecting whether we're running mozinstall >=1.0... 11:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:42:51 INFO - Reading from file tmpfile_stdout 11:42:51 INFO - Output received: 11:42:51 INFO - Usage: mozinstall [options] installer 11:42:51 INFO - Options: 11:42:51 INFO - -h, --help show this help message and exit 11:42:51 INFO - -d DEST, --destination=DEST 11:42:51 INFO - Directory to install application into. [default: 11:42:51 INFO - "/builds/slave/test"] 11:42:51 INFO - --app=APP Application being installed. [default: firefox] 11:42:51 INFO - mkdir: /builds/slave/test/build/application 11:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:43:23 INFO - Reading from file tmpfile_stdout 11:43:23 INFO - Output received: 11:43:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:43:23 INFO - Running post-action listener: _resource_record_post_action 11:43:23 INFO - ##### 11:43:23 INFO - ##### Running run-tests step. 11:43:23 INFO - ##### 11:43:23 INFO - Running pre-action listener: _resource_record_pre_action 11:43:23 INFO - Running main action method: run_tests 11:43:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:43:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:43:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:43:23 INFO - 2016-03-14 11:43:23.724 screenresolution[1640:7393] starting screenresolution argv=screenresolution get 11:43:23 INFO - 2016-03-14 11:43:23.727 screenresolution[1640:7393] Display 0: 1600x1200x32@60 11:43:23 INFO - 2016-03-14 11:43:23.733 screenresolution[1641:7396] starting screenresolution argv=screenresolution list 11:43:23 INFO - Available Modes on Display 0 11:43:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:43:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:43:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:43:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:43:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:43:23 INFO - Intel Iris: 11:43:23 INFO - Chipset Model: Intel Iris 11:43:23 INFO - Type: GPU 11:43:23 INFO - Bus: Built-In 11:43:23 INFO - VRAM (Dynamic, Max): 1536 MB 11:43:23 INFO - Vendor: Intel (0x8086) 11:43:23 INFO - Device ID: 0x0a2e 11:43:23 INFO - Revision ID: 0x0009 11:43:23 INFO - Displays: 11:43:23 INFO - Display: 11:43:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:43:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:43:23 INFO - Display Serial Number: 1600x1200 60 11:43:23 INFO - Main Display: Yes 11:43:23 INFO - Mirror: Off 11:43:23 INFO - Online: Yes 11:43:23 INFO - Rotation: Supported 11:43:23 INFO - Return code: 0 11:43:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:43:23 INFO - Python 2.7.3 11:43:23 INFO - Return code: 0 11:43:23 INFO - grabbing minidump binary from tooltool 11:43:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:23 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 0x10a377d30>, '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 0x10a1dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a36eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:43:23 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 11:43:23 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 11:43:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:43:24 INFO - Return code: 0 11:43:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:43:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:43:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:43:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:43:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:43:25 INFO - Return code: 0 11:43:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--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 11:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0172 --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 11:43:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YvkxD5yiaG/Render', 11:43:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:43:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:43:25 INFO - 'HOME': '/Users/cltbld', 11:43:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:43:25 INFO - 'LOGNAME': 'cltbld', 11:43:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:25 INFO - 'MOZ_NO_REMOTE': '1', 11:43:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:25 INFO - 'NO_EM_RESTART': '1', 11:43:25 INFO - 'PAGER': '/bin/cat', 11:43:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:25 INFO - 'PWD': '/builds/slave/test', 11:43:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:43:25 INFO - 'SHELL': '/bin/bash', 11:43:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCisalq8Ni/Listeners', 11:43:25 INFO - 'TMPDIR': '/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/', 11:43:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:43:25 INFO - 'USER': 'cltbld', 11:43:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:43:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:25 INFO - 'XPC_FLAGS': '0x0', 11:43:25 INFO - 'XPC_SERVICE_NAME': '0', 11:43:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:43:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0172', '--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 11:43:25 INFO - mozversion application_buildid: 20160314103428 11:43:25 INFO - mozversion application_changeset: 98dbd52b1b67eb85f4605b027ead33a3a847ce9a 11:43:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:43:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:43:25 INFO - mozversion application_name: Firefox 11:43:25 INFO - mozversion application_remotingname: firefox-dev 11:43:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:43:25 INFO - mozversion application_vendor: Mozilla 11:43:25 INFO - mozversion application_version: 47.0a2 11:43:25 INFO - mozversion platform_buildid: 20160314103428 11:43:25 INFO - mozversion platform_changeset: 98dbd52b1b67eb85f4605b027ead33a3a847ce9a 11:43:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:43:25 INFO - mozversion platform_version: 47.0a2 11:43:25 INFO - using testdate: 1457981005 11:43:25 INFO - actual date: 1457981005 11:43:25 INFO - starting webserver on 'localhost:49270' 11:43:25 INFO - SUITE-START | Running 2 tests 11:43:25 INFO - TEST-START | dromaeo_css 11:43:25 INFO - operating with platform_type : mac_ 11:43:25 INFO - Initialising browser for dromaeo_css test... 11:43:25 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpvoO7xs/profile http://localhost:49270/getInfo.html) 11:43:28 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 11:43:28 INFO - PROCESS | 1659 | colorDepth:24 11:43:28 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 11:43:28 INFO - PROCESS | 1659 | __metrics 11:43:28 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:43:28 INFO - TEST-INFO | 1659: exit 0 11:43:28 INFO - Browser initialized. 11:43:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:43:28 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmpvoO7xs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:40 INFO - PROCESS | 1662 | RSS: Main: 219914240 11:43:40 INFO - PROCESS | 1662 | 11:44:30 INFO - PROCESS | 1662 | 1457981070289 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] 11:46:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 11:46:43 INFO - PROCESS | 1662 | RSS: Main: 234696704 11:46:43 INFO - PROCESS | 1662 | 11:49:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 11:49:45 INFO - PROCESS | 1662 | RSS: Main: 246091776 11:49:45 INFO - PROCESS | 1662 | 11:52:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 11:52:47 INFO - PROCESS | 1662 | RSS: Main: 248573952 11:52:47 INFO - PROCESS | 1662 | 11:55:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 11:55:50 INFO - PROCESS | 1662 | RSS: Main: 249593856 11:55:50 INFO - PROCESS | 1662 | 11:58:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 11:58:53 INFO - PROCESS | 1662 | RSS: Main: 251633664 11:58:53 INFO - PROCESS | 1662 | 12:01:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 12:01:56 INFO - PROCESS | 1662 | RSS: Main: 254504960 12:01:56 INFO - PROCESS | 1662 | 12:01:56 INFO - PROCESS | 1662 | __start_tp_report 12:01:56 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 12:01:56 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 12:01:56 INFO - PROCESS | 1662 | |i|pagename|runs| 12:01:56 INFO - PROCESS | 1662 | |0;dojo.html;3268.4770436730128;3527.7177825773942;3579.7136229101675;3609.4946707460945;3652.3425783359003;4823.324734537167;5438.83683489495;5758.424157584244;6020.066889632103;6057.485113765324;6011.789587364432;6042.274927008765;6048.576599638027;6075.119107729377;6078.17944577483;5348.438413966536;5428.240046393508;5449.56403487722;5450.29146210994;5465.344158700961;5296.602754793386;5436;5456.427075157111;5487.341519017724;5495.422980587041;5339.466053394668;5383.515483606475;5427.104527752936;5436.565074794027;5514.476124768141;5430.484104010113;5443.1835224716415;5468.589855760794;5475.972620136914;5502.972485137549;5200.843974680765;5384.623076384654;5394;5404.4595540446035;5420.051490989061;4359.585839345257;4844;5906.763729450817;5916.319623243339;5936.940630593682;6258.655773932432;6286.057091436275;6287.9685601572155;6324.146240257553;6329.746810127589;6288.245410550763;6385.808425747235;6442.48460123189;6479.611223326616;6495.447886929616;6094.963856144466;6099.878002439927;6103.267607887037;6107.114468402101;6119;6579.111819904348;6607.537472376887;6630;6655.6339401332425;6662.333766623299;6114.996965385453;6206.534509911775;6243.313235544087;6254.718537665816;6254.843628909313;6355.237371515355;6365.49076073913;6400.911844986364;6405.839854003687;6414.486841052704;6252.249730032425;6265.498760099181;6279.246490421178;6283.748650053946;6296.527760417987;6294.8111556653375;6298.779542715983;6321.715522801485;6327.778527751599;6371.362863713592;4641.675082744243;4765.356676848651;5087.465816089331;5102.285680004802;5122.282880396748;4541.2733962565835;4596.88507787308;4614.861554153381;4622.907541849144;4643.907121857544;5192.506711862367;5985.790497332572;6037.516998640098;6045.455908968214;6097.390260973867;6355.3009168991375;6379.330170332141;6381.266154392211;6402.911505044153;6416.454601358937;5066.594672426197;5474.09677403224;5730.856728581819;5949.315828679671;6096.542759292982;5185.196294574347;5586.24585680936;5604.467575580314;5605.663660180402;5642.548596112383;6567.67161641916;6602.84450221219;6626.171728533934;6641.601503909781;6668.133142691419;6238.251409830849;6316.463100636497;6333.714982825876;6339.397757213057;6366.045093235866;6611.702473388613;6628.83427914306;6636.933630663824;6657;6661.500387470862;6300.117983482224;6319;6322.810315690536;6324.209473815773;6329.860625087528;6205.906911396242;6225.782097626561;6328.525360597881;6339.936600633934;6399;6215.627062376272;6245.469135123565;6246;6249.437550620466;6263.060540918898;6208.503319734501;6218.751249949952;6258.155149055002;6266.154069200599;6278.591891527036;5980.910286345796;6124.411449640054;6186.690665466619;6193.876122477435;6238.064290356483;6217.595856269328;6219.782307619212;6221.4089661482085;6243.469305109116;6248.687565621792;6173.567850250619;6203;6244.094606282155;6257.342978987141;6269.185005949197 12:01:56 INFO - PROCESS | 1662 | |1;ext.html;477.1363831465046;597.6384287506058;614.9077638354248;619.3837132053607;634.752446545847;39790;40182.39726404099;40436.393454098215;40594.188116237696;40693;37524.24951500968;39103.82688519342;41950.16099678005;41953.58046419535;42303.730888073405;8581.356398270123;9550.80898382032;9751.073648003428;9753.317267791257;9777.95111024444;8561.143885611451;9536.237101031935;9809.558569864337;9829.459379734111;9867.60529578816;9703.660371886985;9839.212862970946;9867.40795552269;9876.555555000043;9902.059304366074;9705.738254027003;9872.913979462253;9879.06148915852;9918.801623967516;9925.553350099262;8498.532580708059;9376.437413755197;9771.804563908681;9836.967118452603;9961.003899610054;34586.82706586476;37028.62971370279;40753.796231018954;41175.588244117476;41361.37957930633;3121.2352973521633;3410.8635654573786;3468.115630514228;3790.2419516096893;3951.7826519541413;23081.653775193387;27448.90204391822;27526.311842203904;27735.167944961482;27760.861195694095;2497.2633073243255;2772.3900741836765;2774.3480282133683;2812.4515719434717;2885.249835042904;327227;368526;368942;372239.99999999726;373402;37460;49459.75270123626;49875.501244987085;68772.65613671999;69548.30451695419;47648;48467;48775;48791.5120848787;48880.53358399254;17066;17144.39994600183;17265.39571115005;17367.652646947245;17382.69629777772;11815.527378904919;13595.660108497366;13756.587302380945;13791.793123103162;13845;15739.606509837346;15809.683806323808;15885.602859928364;15895.761563576556;15906.60233494172;6682.398584127354;6749.122614060141;6782.38958493728;6782.457403407716;6810.250872404032;952.6760901293455;955.4744890310441;1069.652362982034;1142.3374442823308;1169.6140273709655;30333.241668958453;30948;30984.69015309818;30996.690033099832;31395.84302078475;1141.7944769941323;1159.7970355187808;1172.7302720374362;1182.526989204308;1190.3512585640847;15506.9224653876;15798.36806527749;15801.525954221392;16039.358425662842;16135.35458581667;557986;714573;771131;789977;792192;66814.66592667006;67047.32952670509;67320.6633966827;67491;67941;1512.9243537823065;1531.9242426511917;1545.103839772929;1550.534839548131;1553.8423874213556;31144.688553114178;31868.5219721709;31949.36101278008;32103.839480802446;32555.837220813744;54828;55217.723911380184;55590.72204639113;55640.16539751988;55713.164302534686;531876;543689;544777;544990;545644;33536.83231583924;34071.65928340784;35096.824515877255;35304.823475882455;35398.823005884806;36547.086322842144;40775.59224407837;40877;47014.76492617515;47357;30550.847245763627;32935.682572697784;37349.43975840419;38767.80616096901;39452;25424.491510170064;30422.847885760428;37535.87392378233;37917.62082379141;38683;32620.673793261765;37899.62100378961;38403.807980959915;38464.423033653955;38738;31603;31755.364892702477;31837.68162318347;31954.84022579872;32251;24784.00863965421;24889.50220995534;25125.497490050464;26869.86565067162;27074.1877743668 12:01:56 INFO - PROCESS | 1662 | |2;jquery.html;381.6565091417725;389.8732911803664;391.8804764546814;393.5670762161622;397.316615421475;19938.601227975432;21898.343049708496;22282.888585557048;22809.771902280972;22924.65613015804;21961.01175447105;22003.559928801453;22263.777362226374;22269.554608907813;22371;5844.91232631512;5918.674472903988;6148.047052706837;6152.261728592575;6178.41305076017;6017.819465416044;6093.695315234243;6108.8472788180425;6118.541109416811;6122.295935967354;5030.723310217955;6088.634681919077;6096.390360963913;6111.511079113682;6125.142480052797;6001.579889407743;6078.118672792442;6100.908486372708;6135.2024236849375;6156.230471191101;5237.266782650432;5281.287026251445;5292.894142117175;5302.628815982845;5332.813351532716;26128.86935565329;26548.203553893414;26734.930602775865;26920.730792692215;27115.864420677968;2003.8497112716605;2128.4572434029224;2173.7608863025052;2200.8019278265033;2240.2383189715574;9991.600335986552;10356.326838755533;11429.314241145476;11471.48378322969;14891.776623350659;1794.4257837492007;1826.9543261418437;1838.9908050459662;1873.175802646831;1929.4693959161202;98688.51967220497;103783;105541;107497;108671.99999999921;11780.99861511764;12020.09849261309;12050.276983381025;12125.636230913087;12163.635090947286;14429;14515.201663908587;14557.636059098608;14569.490067847786;14615.78076328856;7015.473839462061;8789.428687135443;9049.185573298435;9142.588583513758;9145.131212534798;9187.908120918839;9256.53717314145;9267;9353.064693530592;9366.718998430058;4228.710243375738;4412.271975124068;4546.74992875395;4620.214563524209;4656.138614356355;1721.9913900430417;1977.0905383523452;1982.3260091568936;2010.939671809848;2049.5081180516568;902.2105657549644;966.3380584299778;983.1958356416056;1001.2140469731225;1011.5245834457793;20959;22764.317070487912;23121.07515699353;23245.88377058104;23406.414839629146;1024.2229731415987;1033.4006276359694;1049.9527521261562;1097.939613321259;1119.6025410978984;11326.716832079099;11681.299122052704;11702.122340824471;11708.238964467453;11709.765804683859;694857;700600;705776;707780;714789;114571;120941;121048.39475802565;121091;122344;1020.2450186861669;1127.0420142878488;1140.880207578209;1146.896779289868;1147.9598214062635;19093.90453047726;19951.401457956286;20018.099185536394;20053.39839804808;20104.49738756543;51274.487255128464;53027;53372.73313633407;53764.193537096195;53940.460595393546;57889;75068.62465687856;79380;79704;81876.59061704653;8190.549519776469;8344.87482687748;8449.02836173848;8516.659333626585;8567.785805354915;12568.497260109492;13554.93222533881;13724.65688357759;14033.877289816586;14036;11496.195266331277;11640.708982275171;11824.467898944396;11871.109666774853;11971.64085077449;11516.251443656136;11691.064714822964;11742.765144696887;11908.702282443008;12092.395380230777;11832.467538960595;11987;12031.398430078636;12167.39163041862;12216.694582635506;7954.681812727426;8107.797305067421;8345.123762004901;8449.87325190135;8812.867806982773;8503.74488765338;10906.400147991937;11924.403779810802;12001.519939202333;12159.817602736142 12:01:56 INFO - PROCESS | 1662 | |3;mootools.html;1658.1046235033082;1668.5578321744736;2008.9397318080453;2023.7470316210465;2075.138817390783;8531.317494600433;9168.679096231634;9333.253339732813;9583.66457173999;9603.423794572322;9336;9368.110029547199;9370.625174992992;9503.192228660555;9539.379940303892;2579.767820896119;2596.5845464725694;2618.986905065472;2619.541580223463;2629.3426643339167;2548.7578680025367;2607.621894825249;2612.7517885800817;2617.0895246470086;2617.345663584104;2573.5110329037516;2577.7937764978756;2582.3156863431204;2610.765031147196;2612.05965852293;2406.68713067301;2424.030387844867;2537.3022418834876;2567.8459292442512;2575.4720282342073;2557.6419301297647;2558.961615575768;2581.819272650915;2587.4178309880313;2620.868956552184;8104.270615644561;9466.479343636098;9539.14147726708;9589.136977671973;9637.807243855084;4700.858974230779;4941.728204948727;5035.471275516092;5798.739056742456;6003.27960644721;3593.1735700788704;3644.835982380799;3676.466912297702;3737.8131093445218;3752.418375151856;1066.7653116314398;1081.302559848901;1085.3867564825848;1115.2137742891243;1118.9552417903274;11037.668869933916;12711.173773704772;12876.549320773822;12897.935510322483;13055.151415157985;5203.479652034842;5224.92162617561;5302.840914772563;5316.73416329182;5355.116405793078;9530;11091.279066860629;11194.048505877092;11199.832002519968;11210.383428911487;5791.8552036199435;5904.5571582131515;5927.4665280125;6013.368596297326;6025.246844144482;4723.126221649006;5136.717480538607;5204.375474943031;5270.973645131749;5351.973240133774;4180.916381672349;4266.975925777853;4273.358996150602;4280.379344994958;4281.850135245251;1261.0605099201155;1377.2769296119618;1381.295539274977;1403.1440821099122;1411.0475429085327;1416.46174453709;1429.221074514392;1447.131720967432;1451.0713143588112;1473.300182413345;8547.914520854712;8742.694005709769;8764.079771624016;8770.035296117421;8779.561021948877;539.9649022813504;550.7741825851382;554.1936482418072;554.9139883318093;556.6882545774379;6518.250401203923;6531.640759758164;6593.571417857824;6611.63636000015;6625.469962403093;11236.606718764804;11625.24435911663;11642.359670218219;11726.237794543327;11739.47172377245;11123.610673626385;11465.140114491447;11500.424978751029;11516.366599837089;11632.243904146204;8840.292776577859;8854.64581416749;8929.553522323858;9013.63945442188;9105.271578273721;8433.83132337362;8452.112528184452;8648.264897483785;8652.480851148952;8661.177188167114;9928.900710993086;10144.746381340525;10265.486725663537;10265.9486702569;10268.486575671037;10301.690949271533;10383.792324153626;10549.89450105489;10585.364878107339;10689.251752377259;7894;8470.449420787629;8676.392652514263;8696.086910874266;8855.468671879707;8804.647814087364;8813.25087367581;8816.647334106563;8853.468791872509;8894.73315800527;7599.088109426904;7643.656035478528;7758;7920.366370690215;7988.600569971594;6761.256261811295;7290.307420795016;7601.239876012354;7642.312191902755;7801.258880406579;8037.517748935083;8134.87797683047;8139.511629302261;8160.183981601793;8199.057108432367;7212.062431883822;7339.6330183489545;7378.7786366406945;7398.852022959403;7426.74006409773;7552.433567482571;7559;7613.9238607613215;7620.771376858703;7629.504082234859 12:01:56 INFO - PROCESS | 1662 | |4;prototype.html;341.56621091214157;344.7552237911083;346.2227299712147;350.05485189987036;352.2286193236813;7041.50709450338;7050.4007159391385;7072.575645461263;7087.68105435256;7108.1470223573115;6968.442524598033;6978.162620485549;6986.126734158231;7006.334398232172;7020.473464490158;4909.116359055369;4984.202527595586;5087.236914462842;5087.414947281054;5166.5866730661555;4146.8963275918195;4391.451068616423;4651.3720647712635;5105.948940510584;5112.054269960069;4565.840195593155;4827.662063655545;5004.8999020019755;5031.2453132030305;5052.343195384595;5026.648134630559;5026.849194524152;5052.8484145475695;5054.140796064659;5067.721275329855;4379.1022840317655;4379.926917905102;4388.802503887333;4393.714408563465;4404;6451.645159516224;6700.731970721165;6781.593104413701;6781.694823732944;6831.146106736658;4965.354503914468;5826.388229235911;5879.353271140171;5923.970380148072;5934.8813023739285;7445.553266804009;7458.776236712907;7464.589447580381;7494.437917156235;7581.469297149201;4801.927971080437;4818.614510839125;4827.710337379768;4835.540623640749;4836.274558816171;7174.246704096047;7902.960485197537;7935.523868567847;7965.721199757981;7968.52188868664;4738.834140805125;4763.118823017753;4811.879703007453;4818.229083346648;4823.1800593899125;4906.31311616374;4912.214045752734;4919.311296418504;4923.286123512143;4926.950730492649;5905;5941.970290148608;5950.940490595039;5966.880662386815;5978.820635380858;7564.697412103455;7584.54492730438;7588.392928565812;7597.734079307198;7608.125065617525;1442.8052212951118;1632.934682612706;1669.5325308913523;1675.6146086399951;1702.2765324736938;954.6229239450378;1087.0108201536564;1105.3478447715725;1108.2187058124002;1110.7389763405592;6945.40964018054;6956.582605043714;6988.615626140509;6991.335823096798;6998.810202265627;7802.68789248435;7806.960965195138;7816.960915195387;7819.296263336327;7823.943767591302;6921.377076063179;6936.2023367312395;6972.860542789116;6973.825654358681;6980.127484064492;4016.578259282792;4092.672586193157;4122.773247471418;4127.938080928789;4136.4415803866095;7109.791335472982;7808.336291415293;8149.103598604149;8176.509409435453;8217.465864718773;8171.79570510742;8176.754697359089;8182.263596276363;8183.795405114801;8189.549574773326;6728.932710672831;8234.711785087493;8239.052508961426;8259.174082591693;8277.089520152658;7626.885596716164;7844.4116691247245;7884.329831964347;7923.881141782763;7931.682732690628;6262.812115636538;7775.14473407936;7775.961120194363;7793.64928578204;7813.570253636105;8218.958905205436;8222.62998165096;8224.218699223564;8231.506109633201;8261.752147435587;4406.845760398371;5086.847394578169;5092.083424983539;5160.148575485153;5180.61145414103;5956.761729530944;6812.182538095262;7526.5860377679755;7563;7828.021497312836;7434.814129646802;7560.130584982798;7626.694932202871;7636.656350464354;7650.273224043707;7564.243575642392;7607;7607.695692172472;7618.619069046415;7641.961790191236;7445;7447.441441891988;7452;7455.142658594114;7462.253774622494;7414.406847452299;7507.512011719221;7608.467407281437;7618.504797188165;7626.474705059121;7422.220666829905;7426.777196684108;7435.739749108971;7445.9627701861145;7478.6260686966525 12:01:56 INFO - PROCESS | 1662 | |5;yui.html;727.1819203396178;752.7892190186747;759.3848982324317;770.1836053782987;781.4061313401817;14924.776128358084;15005;15201.467948621801;15377.923110384447;15410.306536205855;14036.228007459586;14061.015728898981;14068.648283792885;14073.437062517512;14077.366518506666;783.576868491017;958.4345236310576;972.3776782858976;987.5457289646771;999.5901680311038;953.7377221264138;967.8790151231096;986.9242525647044;990.1929927109383;996.5515518016886;1016.4612755239698;1036.4662198967537;1057.783154453339;1059.1315121600292;1060.512164404375;997.4464172384323;1031.6543957774154;1038.2368958815264;1050.3120456101267;1052.221356196413;692.9376356127973;755.4711701808756;768.5311959704576;784.3137254901961;784.901887264092;14989.400423983028;15051.849481505154;15272.541823745305;15286.082835029934;15331.540053798404;12082;12809;13031.674208144777;13033.15284506504;13225.73548529024;10158.542865570993;10362.27464077515;10382.480875956171;10537.315074520131;10549.84175237372;3696.131409118855;3743.6630703236565;4181.351890456984;4362.280223763075;4384.714993525411;67286.99069513961;79643.20356796416;82056;83645;85115;9941.40351578893;10020.498975051218;10033.39799612011;10177.949110254402;10229.437380943971;23057.962391692414;23247.7675223249;23523.41191470227;24207.878960605085;24520.509589808105;7613.6573854176695;7638.847223055619;7714.228577142353;7715.267049630276;7724.0731112266885;4113.382992551141;4140.855070072533;4168.624823765876;4170.311898536768;4198.6221240088535;3667.963320366762;3718.1076541630355;3721.6464435878547;3730.0488375464624;3743.868964586281;645.1484041065842;667.4026746062248;668.4318329420051;668.8428219368444;669.5614372585964;542.896849598575;588.3616276340133;603.7221297261555;607.6536374266714;616.7748771698298;8337.916620833714;8582.87125693115;8602.18279263469;8603.612837422332;8793.780155496035;521.1089037745422;610.1214251477858;631.8988961766096;639.6226226526372;640.0942666127471;3879.6120387960977;3962.385830196324;4052.696047796368;4061.593840615974;4169.7453819271095;97520;97927.53108703376;99912;100192;100861;82133.58933205415;82227.5888620553;82591.58704206561;82695;83345;60668;76248.23751762412;76268;76813.84779228205;77164.61417692875;7952.6421311042295;8210.58947052657;8248.876266856121;8332.16678332162;8352.540610266493;46552.53447465482;46570.6028819136;47375.52624473711;48030.27954580754;49800.50199497959;63367.6831615839;66419.33580664132;68836.31163688499;70216.64891675509;74953.62523187349;9774.462404567532;11319.830202546804;11356.54573817038;11570;11576.24754390962;12176.634700958986;12188.024958003161;12227.816582751444;12300.446479908247;13247.337633118499;11858.34779087124;11965.700857478632;12011.579594714143;12283.201591896499;12300.692482688004;11670.241434306743;12151.696207594881;12163.331016794162;12175.025997920322;12192.902638762554;10099.495025248854;11667.941660291644;12125.75748485043;12133.272003679807;12179.39103044862;9476.57355418994;9686.951565242129;9786.363886347364;10052.69841904744;10146.441945693057;9851.950740246253;9934.850977235492;9958;9968.950155249468;10019 12:01:56 INFO - PROCESS | 1662 | __end_tp_report 12:01:56 INFO - PROCESS | 1662 | __start_cc_report 12:01:56 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,357 12:01:56 INFO - PROCESS | 1662 | __end_cc_report 12:01:56 INFO - PROCESS | 1662 | __startTimestamp1457982116020__endTimestamp 12:01:56 INFO - PROCESS | 1662 | 12:01:56 INFO - PROCESS | 1662 | ------- Summary: start ------- 12:01:56 INFO - PROCESS | 1662 | Number of tests: 6 12:01:56 INFO - PROCESS | 1662 | 12:01:56 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5898.05 Median:6205.91 stddev:675.12 (10.9%) stddev-sans-first:644.91 12:01:56 INFO - PROCESS | 1662 | Values: 3268.5 3527.7 3579.7 3609.5 3652.3 4823.3 5438.8 5758.4 6020.1 6057.5 6011.8 6042.3 6048.6 6075.1 6078.2 5348.4 5428.2 5449.6 5450.3 5465.3 5296.6 5436.0 5456.4 5487.3 5495.4 5339.5 5383.5 5427.1 5436.6 5514.5 5430.5 5443.2 5468.6 5476.0 5503.0 5200.8 5384.6 5394.0 5404.5 5420.1 4359.6 4844.0 5906.8 5916.3 5936.9 6258.7 6286.1 6288.0 6324.1 6329.7 6288.2 6385.8 6442.5 6479.6 6495.4 6095.0 6099.9 6103.3 6107.1 6119.0 6579.1 6607.5 6630.0 6655.6 6662.3 6115.0 6206.5 6243.3 6254.7 6254.8 6355.2 6365.5 6400.9 6405.8 6414.5 6252.2 6265.5 6279.2 6283.7 6296.5 6294.8 6298.8 6321.7 6327.8 6371.4 4641.7 4765.4 5087.5 5102.3 5122.3 4541.3 4596.9 4614.9 4622.9 4643.9 5192.5 5985.8 6037.5 6045.5 6097.4 6355.3 6379.3 6381.3 6402.9 6416.5 5066.6 5474.1 5730.9 5949.3 6096.5 5185.2 5586.2 5604.5 5605.7 5642.5 6567.7 6602.8 6626.2 6641.6 6668.1 6238.3 6316.5 6333.7 6339.4 6366.0 6611.7 6628.8 6636.9 6657.0 6661.5 6300.1 6319.0 6322.8 6324.2 6329.9 6205.9 6225.8 6328.5 6339.9 6399.0 6215.6 6245.5 6246.0 6249.4 6263.1 6208.5 6218.8 6258.2 6266.2 6278.6 5980.9 6124.4 6186.7 6193.9 6238.1 6217.6 6219.8 6221.4 6243.5 6248.7 6173.6 6203.0 6244.1 6257.3 6269.2 12:01:56 INFO - PROCESS | 1662 | 12:01:56 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:67636.59 Median:38160.71 stddev:151812.66 (397.8%) stddev-sans-first:152154.79 12:01:56 INFO - PROCESS | 1662 | Values: 477.1 597.6 614.9 619.4 634.8 39790.0 40182.4 40436.4 40594.2 40693.0 37524.2 39103.8 41950.2 41953.6 42303.7 8581.4 9550.8 9751.1 9753.3 9778.0 8561.1 9536.2 9809.6 9829.5 9867.6 9703.7 9839.2 9867.4 9876.6 9902.1 9705.7 9872.9 9879.1 9918.8 9925.6 8498.5 9376.4 9771.8 9837.0 9961.0 34586.8 37028.6 40753.8 41175.6 41361.4 3121.2 3410.9 3468.1 3790.2 3951.8 23081.7 27448.9 27526.3 27735.2 27760.9 2497.3 2772.4 2774.3 2812.5 2885.2 327227.0 368526.0 368942.0 372240.0 373402.0 37460.0 49459.8 49875.5 68772.7 69548.3 47648.0 48467.0 48775.0 48791.5 48880.5 17066.0 17144.4 17265.4 17367.7 17382.7 11815.5 13595.7 13756.6 13791.8 13845.0 15739.6 15809.7 15885.6 15895.8 15906.6 6682.4 6749.1 6782.4 6782.5 6810.3 952.7 955.5 1069.7 1142.3 1169.6 30333.2 30948.0 30984.7 30996.7 31395.8 1141.8 1159.8 1172.7 1182.5 1190.4 15506.9 15798.4 15801.5 16039.4 16135.4 557986.0 714573.0 771131.0 789977.0 792192.0 66814.7 67047.3 67320.7 67491.0 67941.0 1512.9 1531.9 1545.1 1550.5 1553.8 31144.7 31868.5 31949.4 32103.8 32555.8 54828.0 55217.7 55590.7 55640.2 55713.2 531876.0 543689.0 544777.0 544990.0 545644.0 33536.8 34071.7 35096.8 35304.8 35398.8 36547.1 40775.6 40877.0 47014.8 47357.0 30550.8 32935.7 37349.4 38767.8 39452.0 25424.5 30422.8 37535.9 37917.6 38683.0 32620.7 37899.6 38403.8 38464.4 38738.0 31603.0 31755.4 31837.7 31954.8 32251.0 24784.0 24889.5 25125.5 26869.9 27074.2 12:01:56 INFO - PROCESS | 1662 | 12:01:56 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:37749.98 Median:22326.94 stddev:116249.37 (520.7%) stddev-sans-first:116541.62 12:01:56 INFO - PROCESS | 1662 | Values: 381.7 389.9 391.9 393.6 397.3 19938.6 21898.3 22282.9 22809.8 22924.7 21961.0 22003.6 22263.8 22269.6 22371.0 5844.9 5918.7 6148.0 6152.3 6178.4 6017.8 6093.7 6108.8 6118.5 6122.3 5030.7 6088.6 6096.4 6111.5 6125.1 6001.6 6078.1 6100.9 6135.2 6156.2 5237.3 5281.3 5292.9 5302.6 5332.8 26128.9 26548.2 26734.9 26920.7 27115.9 2003.8 2128.5 2173.8 2200.8 2240.2 9991.6 10356.3 11429.3 11471.5 14891.8 1794.4 1827.0 1839.0 1873.2 1929.5 98688.5 103783.0 105541.0 107497.0 108672.0 11781.0 12020.1 12050.3 12125.6 12163.6 14429.0 14515.2 14557.6 14569.5 14615.8 7015.5 8789.4 9049.2 9142.6 9145.1 9187.9 9256.5 9267.0 9353.1 9366.7 4228.7 4412.3 4546.7 4620.2 4656.1 1722.0 1977.1 1982.3 2010.9 2049.5 902.2 966.3 983.2 1001.2 1011.5 20959.0 22764.3 23121.1 23245.9 23406.4 1024.2 1033.4 1050.0 1097.9 1119.6 11326.7 11681.3 11702.1 11708.2 11709.8 694857.0 700600.0 705776.0 707780.0 714789.0 114571.0 120941.0 121048.4 121091.0 122344.0 1020.2 1127.0 1140.9 1146.9 1148.0 19093.9 19951.4 20018.1 20053.4 20104.5 51274.5 53027.0 53372.7 53764.2 53940.5 57889.0 75068.6 79380.0 79704.0 81876.6 8190.5 8344.9 8449.0 8516.7 8567.8 12568.5 13554.9 13724.7 14033.9 14036.0 11496.2 11640.7 11824.5 11871.1 11971.6 11516.3 11691.1 11742.8 11908.7 12092.4 11832.5 11987.0 12031.4 12167.4 12216.7 7954.7 8107.8 8345.1 8449.9 8812.9 8503.7 10906.4 11924.4 12001.5 12159.8 12:01:56 INFO - PROCESS | 1662 | 12:01:56 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6452.13 Median:5247.95 stddev:3448.13 (65.7%) stddev-sans-first:3438.98 12:01:56 INFO - PROCESS | 1662 | Values: 1658.1 1668.6 2008.9 2023.7 2075.1 8531.3 9168.7 9333.3 9583.7 9603.4 9336.0 9368.1 9370.6 9503.2 9539.4 2579.8 2596.6 2619.0 2619.5 2629.3 2548.8 2607.6 2612.8 2617.1 2617.3 2573.5 2577.8 2582.3 2610.8 2612.1 2406.7 2424.0 2537.3 2567.8 2575.5 2557.6 2559.0 2581.8 2587.4 2620.9 8104.3 9466.5 9539.1 9589.1 9637.8 4700.9 4941.7 5035.5 5798.7 6003.3 3593.2 3644.8 3676.5 3737.8 3752.4 1066.8 1081.3 1085.4 1115.2 1119.0 11037.7 12711.2 12876.5 12897.9 13055.2 5203.5 5224.9 5302.8 5316.7 5355.1 9530.0 11091.3 11194.0 11199.8 11210.4 5791.9 5904.6 5927.5 6013.4 6025.2 4723.1 5136.7 5204.4 5271.0 5352.0 4180.9 4267.0 4273.4 4280.4 4281.9 1261.1 1377.3 1381.3 1403.1 1411.0 1416.5 1429.2 1447.1 1451.1 1473.3 8547.9 8742.7 8764.1 8770.0 8779.6 540.0 550.8 554.2 554.9 556.7 6518.3 6531.6 6593.6 6611.6 6625.5 11236.6 11625.2 11642.4 11726.2 11739.5 11123.6 11465.1 11500.4 11516.4 11632.2 8840.3 8854.6 8929.6 9013.6 9105.3 8433.8 8452.1 8648.3 8652.5 8661.2 9928.9 10144.7 10265.5 10265.9 10268.5 10301.7 10383.8 10549.9 10585.4 10689.3 7894.0 8470.4 8676.4 8696.1 8855.5 8804.6 8813.3 8816.6 8853.5 8894.7 7599.1 7643.7 7758.0 7920.4 7988.6 6761.3 7290.3 7601.2 7642.3 7801.3 8037.5 8134.9 8139.5 8160.2 8199.1 7212.1 7339.6 7378.8 7398.9 7426.7 7552.4 7559.0 7613.9 7620.8 7629.5 12:01:56 INFO - PROCESS | 1662 | 12:01:56 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:6114.42 Median:6979.15 stddev:2008.43 (28.8%) stddev-sans-first:1966.77 12:01:56 INFO - PROCESS | 1662 | Values: 341.6 344.8 346.2 350.1 352.2 7041.5 7050.4 7072.6 7087.7 7108.1 6968.4 6978.2 6986.1 7006.3 7020.5 4909.1 4984.2 5087.2 5087.4 5166.6 4146.9 4391.5 4651.4 5105.9 5112.1 4565.8 4827.7 5004.9 5031.2 5052.3 5026.6 5026.8 5052.8 5054.1 5067.7 4379.1 4379.9 4388.8 4393.7 4404.0 6451.6 6700.7 6781.6 6781.7 6831.1 4965.4 5826.4 5879.4 5924.0 5934.9 7445.6 7458.8 7464.6 7494.4 7581.5 4801.9 4818.6 4827.7 4835.5 4836.3 7174.2 7903.0 7935.5 7965.7 7968.5 4738.8 4763.1 4811.9 4818.2 4823.2 4906.3 4912.2 4919.3 4923.3 4927.0 5905.0 5942.0 5950.9 5966.9 5978.8 7564.7 7584.5 7588.4 7597.7 7608.1 1442.8 1632.9 1669.5 1675.6 1702.3 954.6 1087.0 1105.3 1108.2 1110.7 6945.4 6956.6 6988.6 6991.3 6998.8 7802.7 7807.0 7817.0 7819.3 7823.9 6921.4 6936.2 6972.9 6973.8 6980.1 4016.6 4092.7 4122.8 4127.9 4136.4 7109.8 7808.3 8149.1 8176.5 8217.5 8171.8 8176.8 8182.3 8183.8 8189.5 6728.9 8234.7 8239.1 8259.2 8277.1 7626.9 7844.4 7884.3 7923.9 7931.7 6262.8 7775.1 7776.0 7793.6 7813.6 8219.0 8222.6 8224.2 8231.5 8261.8 4406.8 5086.8 5092.1 5160.1 5180.6 5956.8 6812.2 7526.6 7563.0 7828.0 7434.8 7560.1 7626.7 7636.7 7650.3 7564.2 7607.0 7607.7 7618.6 7642.0 7445.0 7447.4 7452.0 7455.1 7462.3 7414.4 7507.5 7608.5 7618.5 7626.5 7422.2 7426.8 7435.7 7446.0 7478.6 12:01:56 INFO - PROCESS | 1662 | 12:01:56 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18880.67 Median:4373.50 stddev:26655.13 (609.5%) stddev-sans-first:26695.05 12:01:56 INFO - PROCESS | 1662 | Values: 727.2 752.8 759.4 770.2 781.4 14924.8 15005.0 15201.5 15377.9 15410.3 14036.2 14061.0 14068.6 14073.4 14077.4 783.6 958.4 972.4 987.5 999.6 953.7 967.9 986.9 990.2 996.6 1016.5 1036.5 1057.8 1059.1 1060.5 997.4 1031.7 1038.2 1050.3 1052.2 692.9 755.5 768.5 784.3 784.9 14989.4 15051.8 15272.5 15286.1 15331.5 12082.0 12809.0 13031.7 13033.2 13225.7 10158.5 10362.3 10382.5 10537.3 10549.8 3696.1 3743.7 4181.4 4362.3 4384.7 67287.0 79643.2 82056.0 83645.0 85115.0 9941.4 10020.5 10033.4 10177.9 10229.4 23058.0 23247.8 23523.4 24207.9 24520.5 7613.7 7638.8 7714.2 7715.3 7724.1 4113.4 4140.9 4168.6 4170.3 4198.6 3668.0 3718.1 3721.6 3730.0 3743.9 645.1 667.4 668.4 668.8 669.6 542.9 588.4 603.7 607.7 616.8 8337.9 8582.9 8602.2 8603.6 8793.8 521.1 610.1 631.9 639.6 640.1 3879.6 3962.4 4052.7 4061.6 4169.7 97520.0 97927.5 99912.0 100192.0 100861.0 82133.6 82227.6 82591.6 82695.0 83345.0 60668.0 76248.2 76268.0 76813.8 77164.6 7952.6 8210.6 8248.9 8332.2 8352.5 46552.5 46570.6 47375.5 48030.3 49800.5 63367.7 66419.3 68836.3 70216.6 74953.6 9774.5 11319.8 11356.5 11570.0 11576.2 12176.6 12188.0 12227.8 12300.4 13247.3 11858.3 11965.7 12011.6 12283.2 12300.7 11670.2 12151.7 12163.3 12175.0 12192.9 10099.5 11667.9 12125.8 12133.3 12179.4 9476.6 9687.0 9786.4 10052.7 10146.4 9852.0 9934.9 9958.0 9969.0 10019.0 12:01:56 INFO - PROCESS | 1662 | -------- Summary: end -------- 12:01:56 INFO - PROCESS | 1662 | 12:01:56 INFO - TEST-INFO | 1662: exit 0 12:01:56 INFO - TEST-OK | dromaeo_css | took 1111067ms 12:01:56 INFO - TEST-START | kraken 12:01:56 INFO - operating with platform_type : mac_ 12:01:56 INFO - Initialising browser for kraken test... 12:01:56 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmptifrY5/profile http://localhost:49270/getInfo.html) 12:01:59 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 12:01:59 INFO - PROCESS | 1675 | colorDepth:24 12:01:59 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 12:01:59 INFO - PROCESS | 1675 | __metrics 12:01:59 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 12:01:59 INFO - TEST-INFO | 1675: exit 0 12:01:59 INFO - Browser initialized. 12:01:59 INFO - Running cycle 1/1 for kraken test... 12:01:59 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/tmptifrY5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:02:11 INFO - PROCESS | 1678 | RSS: Main: 219742208 12:02:11 INFO - PROCESS | 1678 | 12:02:14 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 12:02:15 INFO - PROCESS | 1678 | RSS: Main: 233422848 12:02:15 INFO - PROCESS | 1678 | 12:02:17 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 12:02:18 INFO - PROCESS | 1678 | RSS: Main: 241262592 12:02:18 INFO - PROCESS | 1678 | 12:02:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 12:02:22 INFO - PROCESS | 1678 | RSS: Main: 243978240 12:02:22 INFO - PROCESS | 1678 | 12:02:24 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 12:02:24 INFO - PROCESS | 1678 | RSS: Main: 244510720 12:02:24 INFO - PROCESS | 1678 | 12:02:26 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:27 INFO - PROCESS | 1678 | RSS: Main: 245829632 12:02:27 INFO - PROCESS | 1678 | 12:02:29 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 12:02:30 INFO - PROCESS | 1678 | RSS: Main: 247152640 12:02:30 INFO - PROCESS | 1678 | 12:02:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:33 INFO - PROCESS | 1678 | RSS: Main: 247021568 12:02:33 INFO - PROCESS | 1678 | 12:02:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 12:02:37 INFO - PROCESS | 1678 | RSS: Main: 247783424 12:02:37 INFO - PROCESS | 1678 | 12:02:38 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:02:39 INFO - PROCESS | 1678 | RSS: Main: 247308288 12:02:39 INFO - PROCESS | 1678 | 12:02:41 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:02:42 INFO - PROCESS | 1678 | RSS: Main: 246505472 12:02:42 INFO - PROCESS | 1678 | 12:02:44 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:02:44 INFO - PROCESS | 1678 | RSS: Main: 246259712 12:02:44 INFO - PROCESS | 1678 | 12:02:47 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:02:47 INFO - PROCESS | 1678 | RSS: Main: 246255616 12:02:47 INFO - PROCESS | 1678 | 12:02:50 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:02:50 INFO - PROCESS | 1678 | RSS: Main: 246427648 12:02:50 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 12:02:52 INFO - PROCESS | 1678 | RSS: Main: 248934400 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | __start_tp_report 12:02:52 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 12:02:52 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 12:02:52 INFO - PROCESS | 1678 | |i|pagename|runs| 12:02:52 INFO - PROCESS | 1678 | |0;ai-astar;156;155;160;115;117;129;115;112;123;114 12:02:52 INFO - PROCESS | 1678 | |1;audio-beat-detection;147;120;141;147;123;161;121;152;146;120 12:02:52 INFO - PROCESS | 1678 | |2;audio-dft;195;195;196;199;243;194;194;193;202;200 12:02:52 INFO - PROCESS | 1678 | |3;audio-fft;68;69;73;112;56;55;58;58;112;55 12:02:52 INFO - PROCESS | 1678 | |4;audio-oscillator;83;84;113;79;80;78;115;78;78;115 12:02:52 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;87;85;88;84;91;122;88;87;88;87 12:02:52 INFO - PROCESS | 1678 | |6;imaging-darkroom;93;93;94;94;94;95;98;98;88;141 12:02:52 INFO - PROCESS | 1678 | |7;imaging-desaturate;118;88;145;139;90;88;91;91;94;92 12:02:52 INFO - PROCESS | 1678 | |8;json-parse-financial;53;60;60;59;58;57;65;83;57;52 12:02:52 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;62;65;70;64;73;68;69;65;65;65 12:02:52 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;95;111;99;84;83;81;81;83;83;86 12:02:52 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;131;118;132;135;125;135;136;131;121;137 12:02:52 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;138;136;132;136;131;129;134;136;133;150 12:02:52 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;66;68;88;91;95;73;66;65;68;64 12:02:52 INFO - PROCESS | 1678 | __end_tp_report 12:02:52 INFO - PROCESS | 1678 | __start_cc_report 12:02:52 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,920 12:02:52 INFO - PROCESS | 1678 | __end_cc_report 12:02:52 INFO - PROCESS | 1678 | __startTimestamp1457982172971__endTimestamp 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | ------- Summary: start ------- 12:02:52 INFO - PROCESS | 1678 | Number of tests: 14 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:129.60 Median:126.00 stddev:19.57 (15.5%) stddev-sans-first:18.28 12:02:52 INFO - PROCESS | 1678 | Values: 156.0 155.0 160.0 115.0 117.0 129.0 115.0 112.0 123.0 114.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:146.50 stddev:15.35 (10.5%) stddev-sans-first:15.92 12:02:52 INFO - PROCESS | 1678 | Values: 147.0 120.0 141.0 147.0 123.0 161.0 121.0 152.0 146.0 120.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:201.10 Median:197.50 stddev:15.01 (7.6%) stddev-sans-first:15.76 12:02:52 INFO - PROCESS | 1678 | Values: 195.0 195.0 196.0 199.0 243.0 194.0 194.0 193.0 202.0 200.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:71.60 Median:58.00 stddev:22.24 (38.3%) stddev-sans-first:23.55 12:02:52 INFO - PROCESS | 1678 | Values: 68.0 69.0 73.0 112.0 56.0 55.0 58.0 58.0 112.0 55.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:78.50 stddev:16.72 (21.3%) stddev-sans-first:17.52 12:02:52 INFO - PROCESS | 1678 | Values: 83.0 84.0 113.0 79.0 80.0 78.0 115.0 78.0 78.0 115.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:87.50 stddev:11.16 (12.7%) stddev-sans-first:11.75 12:02:52 INFO - PROCESS | 1678 | Values: 87.0 85.0 88.0 84.0 91.0 122.0 88.0 87.0 88.0 87.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:98.80 Median:94.00 stddev:15.09 (16.1%) stddev-sans-first:15.86 12:02:52 INFO - PROCESS | 1678 | Values: 93.0 93.0 94.0 94.0 94.0 95.0 98.0 98.0 88.0 141.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:103.60 Median:90.50 stddev:22.09 (24.4%) stddev-sans-first:22.80 12:02:52 INFO - PROCESS | 1678 | Values: 118.0 88.0 145.0 139.0 90.0 88.0 91.0 91.0 94.0 92.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:59.50 stddev:8.75 (14.7%) stddev-sans-first:8.86 12:02:52 INFO - PROCESS | 1678 | Values: 53.0 60.0 60.0 59.0 58.0 57.0 65.0 83.0 57.0 52.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:3.31 (5.0%) stddev-sans-first:3.06 12:02:52 INFO - PROCESS | 1678 | Values: 62.0 65.0 70.0 64.0 73.0 68.0 69.0 65.0 65.0 65.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:83.50 stddev:9.94 (11.9%) stddev-sans-first:10.26 12:02:52 INFO - PROCESS | 1678 | Values: 95.0 111.0 99.0 84.0 83.0 81.0 81.0 83.0 83.0 86.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:133.50 stddev:6.59 (4.9%) stddev-sans-first:6.98 12:02:52 INFO - PROCESS | 1678 | Values: 131.0 118.0 132.0 135.0 125.0 135.0 136.0 131.0 121.0 137.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:136.00 stddev:5.78 (4.2%) stddev-sans-first:6.06 12:02:52 INFO - PROCESS | 1678 | Values: 138.0 136.0 132.0 136.0 131.0 129.0 134.0 136.0 133.0 150.0 12:02:52 INFO - PROCESS | 1678 | 12:02:52 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:70.50 stddev:12.05 (17.1%) stddev-sans-first:12.39 12:02:52 INFO - PROCESS | 1678 | Values: 66.0 68.0 88.0 91.0 95.0 73.0 66.0 65.0 68.0 64.0 12:02:52 INFO - PROCESS | 1678 | -------- Summary: end -------- 12:02:52 INFO - PROCESS | 1678 | 12:02:53 INFO - TEST-INFO | 1678: exit 0 12:02:53 INFO - TEST-OK | kraken | took 57135ms 12:02:53 INFO - SUITE-END | took 1168s 12:02:54 INFO - Completed test suite (00:19:28) 12:02:54 INFO - javascript benchmark 12:02:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3268.4770436730128, 3527.7177825773942, 3579.7136229101675, 3609.4946707460945, 3652.3425783359003, 4823.324734537167, 5438.83683489495, 5758.424157584244, 6020.066889632103, 6057.485113765324, 6011.789587364432, 6042.274927008765, 6048.576599638027, 6075.119107729377, 6078.17944577483, 5348.438413966536, 5428.240046393508, 5449.56403487722, 5450.29146210994, 5465.344158700961, 5296.602754793386, 5436.0, 5456.427075157111, 5487.341519017724, 5495.422980587041, 5339.466053394668, 5383.515483606475, 5427.104527752936, 5436.565074794027, 5514.476124768141, 5430.484104010113, 5443.1835224716415, 5468.589855760794, 5475.972620136914, 5502.972485137549, 5200.843974680765, 5384.623076384654, 5394.0, 5404.4595540446035, 5420.051490989061, 4359.585839345257, 4844.0, 5906.763729450817, 5916.319623243339, 5936.940630593682, 6258.655773932432, 6286.057091436275, 6287.9685601572155, 6324.146240257553, 6329.746810127589, 6288.245410550763, 6385.808425747235, 6442.48460123189, 6479.611223326616, 6495.447886929616, 6094.963856144466, 6099.878002439927, 6103.267607887037, 6107.114468402101, 6119.0, 6579.111819904348, 6607.537472376887, 6630.0, 6655.6339401332425, 6662.333766623299, 6114.996965385453, 6206.534509911775, 6243.313235544087, 6254.718537665816, 6254.843628909313, 6355.237371515355, 6365.49076073913, 6400.911844986364, 6405.839854003687, 6414.486841052704, 6252.249730032425, 6265.498760099181, 6279.246490421178, 6283.748650053946, 6296.527760417987, 6294.8111556653375, 6298.779542715983, 6321.715522801485, 6327.778527751599, 6371.362863713592, 4641.675082744243, 4765.356676848651, 5087.465816089331, 5102.285680004802, 5122.282880396748, 4541.2733962565835, 4596.88507787308, 4614.861554153381, 4622.907541849144, 4643.907121857544, 5192.506711862367, 5985.790497332572, 6037.516998640098, 6045.455908968214, 6097.390260973867, 6355.3009168991375, 6379.330170332141, 6381.266154392211, 6402.911505044153, 6416.454601358937, 5066.594672426197, 5474.09677403224, 5730.856728581819, 5949.315828679671, 6096.542759292982, 5185.196294574347, 5586.24585680936, 5604.467575580314, 5605.663660180402, 5642.548596112383, 6567.67161641916, 6602.84450221219, 6626.171728533934, 6641.601503909781, 6668.133142691419, 6238.251409830849, 6316.463100636497, 6333.714982825876, 6339.397757213057, 6366.045093235866, 6611.702473388613, 6628.83427914306, 6636.933630663824, 6657.0, 6661.500387470862, 6300.117983482224, 6319.0, 6322.810315690536, 6324.209473815773, 6329.860625087528, 6205.906911396242, 6225.782097626561, 6328.525360597881, 6339.936600633934, 6399.0, 6215.627062376272, 6245.469135123565, 6246.0, 6249.437550620466, 6263.060540918898, 6208.503319734501, 6218.751249949952, 6258.155149055002, 6266.154069200599, 6278.591891527036, 5980.910286345796, 6124.411449640054, 6186.690665466619, 6193.876122477435, 6238.064290356483, 6217.595856269328, 6219.782307619212, 6221.4089661482085, 6243.469305109116, 6248.687565621792, 6173.567850250619, 6203.0, 6244.094606282155, 6257.342978987141, 6269.185005949197], "unit": "score", "name": "dojo.html", "value": 5856.172077020672}, {"lowerIsBetter": false, "replicates": [477.1363831465046, 597.6384287506058, 614.9077638354248, 619.3837132053607, 634.752446545847, 39790.0, 40182.39726404099, 40436.393454098215, 40594.188116237696, 40693.0, 37524.24951500968, 39103.82688519342, 41950.16099678005, 41953.58046419535, 42303.730888073405, 8581.356398270123, 9550.80898382032, 9751.073648003428, 9753.317267791257, 9777.95111024444, 8561.143885611451, 9536.237101031935, 9809.558569864337, 9829.459379734111, 9867.60529578816, 9703.660371886985, 9839.212862970946, 9867.40795552269, 9876.555555000043, 9902.059304366074, 9705.738254027003, 9872.913979462253, 9879.06148915852, 9918.801623967516, 9925.553350099262, 8498.532580708059, 9376.437413755197, 9771.804563908681, 9836.967118452603, 9961.003899610054, 34586.82706586476, 37028.62971370279, 40753.796231018954, 41175.588244117476, 41361.37957930633, 3121.2352973521633, 3410.8635654573786, 3468.115630514228, 3790.2419516096893, 3951.7826519541413, 23081.653775193387, 27448.90204391822, 27526.311842203904, 27735.167944961482, 27760.861195694095, 2497.2633073243255, 2772.3900741836765, 2774.3480282133683, 2812.4515719434717, 2885.249835042904, 327227.0, 368526.0, 368942.0, 372239.99999999726, 373402.0, 37460.0, 49459.75270123626, 49875.501244987085, 68772.65613671999, 69548.30451695419, 47648.0, 48467.0, 48775.0, 48791.5120848787, 48880.53358399254, 17066.0, 17144.39994600183, 17265.39571115005, 17367.652646947245, 17382.69629777772, 11815.527378904919, 13595.660108497366, 13756.587302380945, 13791.793123103162, 13845.0, 15739.606509837346, 15809.683806323808, 15885.602859928364, 15895.761563576556, 15906.60233494172, 6682.398584127354, 6749.122614060141, 6782.38958493728, 6782.457403407716, 6810.250872404032, 952.6760901293455, 955.4744890310441, 1069.652362982034, 1142.3374442823308, 1169.6140273709655, 30333.241668958453, 30948.0, 30984.69015309818, 30996.690033099832, 31395.84302078475, 1141.7944769941323, 1159.7970355187808, 1172.7302720374362, 1182.526989204308, 1190.3512585640847, 15506.9224653876, 15798.36806527749, 15801.525954221392, 16039.358425662842, 16135.35458581667, 557986.0, 714573.0, 771131.0, 789977.0, 792192.0, 66814.66592667006, 67047.32952670509, 67320.6633966827, 67491.0, 67941.0, 1512.9243537823065, 1531.9242426511917, 1545.103839772929, 1550.534839548131, 1553.8423874213556, 31144.688553114178, 31868.5219721709, 31949.36101278008, 32103.839480802446, 32555.837220813744, 54828.0, 55217.723911380184, 55590.72204639113, 55640.16539751988, 55713.164302534686, 531876.0, 543689.0, 544777.0, 544990.0, 545644.0, 33536.83231583924, 34071.65928340784, 35096.824515877255, 35304.823475882455, 35398.823005884806, 36547.086322842144, 40775.59224407837, 40877.0, 47014.76492617515, 47357.0, 30550.847245763627, 32935.682572697784, 37349.43975840419, 38767.80616096901, 39452.0, 25424.491510170064, 30422.847885760428, 37535.87392378233, 37917.62082379141, 38683.0, 32620.673793261765, 37899.62100378961, 38403.807980959915, 38464.423033653955, 38738.0, 31603.0, 31755.364892702477, 31837.68162318347, 31954.84022579872, 32251.0, 24784.00863965421, 24889.50220995534, 25125.497490050464, 26869.86565067162, 27074.1877743668], "unit": "score", "name": "ext.html", "value": 19786.8094348706}, {"lowerIsBetter": false, "replicates": [381.6565091417725, 389.8732911803664, 391.8804764546814, 393.5670762161622, 397.316615421475, 19938.601227975432, 21898.343049708496, 22282.888585557048, 22809.771902280972, 22924.65613015804, 21961.01175447105, 22003.559928801453, 22263.777362226374, 22269.554608907813, 22371.0, 5844.91232631512, 5918.674472903988, 6148.047052706837, 6152.261728592575, 6178.41305076017, 6017.819465416044, 6093.695315234243, 6108.8472788180425, 6118.541109416811, 6122.295935967354, 5030.723310217955, 6088.634681919077, 6096.390360963913, 6111.511079113682, 6125.142480052797, 6001.579889407743, 6078.118672792442, 6100.908486372708, 6135.2024236849375, 6156.230471191101, 5237.266782650432, 5281.287026251445, 5292.894142117175, 5302.628815982845, 5332.813351532716, 26128.86935565329, 26548.203553893414, 26734.930602775865, 26920.730792692215, 27115.864420677968, 2003.8497112716605, 2128.4572434029224, 2173.7608863025052, 2200.8019278265033, 2240.2383189715574, 9991.600335986552, 10356.326838755533, 11429.314241145476, 11471.48378322969, 14891.776623350659, 1794.4257837492007, 1826.9543261418437, 1838.9908050459662, 1873.175802646831, 1929.4693959161202, 98688.51967220497, 103783.0, 105541.0, 107497.0, 108671.99999999921, 11780.99861511764, 12020.09849261309, 12050.276983381025, 12125.636230913087, 12163.635090947286, 14429.0, 14515.201663908587, 14557.636059098608, 14569.490067847786, 14615.78076328856, 7015.473839462061, 8789.428687135443, 9049.185573298435, 9142.588583513758, 9145.131212534798, 9187.908120918839, 9256.53717314145, 9267.0, 9353.064693530592, 9366.718998430058, 4228.710243375738, 4412.271975124068, 4546.74992875395, 4620.214563524209, 4656.138614356355, 1721.9913900430417, 1977.0905383523452, 1982.3260091568936, 2010.939671809848, 2049.5081180516568, 902.2105657549644, 966.3380584299778, 983.1958356416056, 1001.2140469731225, 1011.5245834457793, 20959.0, 22764.317070487912, 23121.07515699353, 23245.88377058104, 23406.414839629146, 1024.2229731415987, 1033.4006276359694, 1049.9527521261562, 1097.939613321259, 1119.6025410978984, 11326.716832079099, 11681.299122052704, 11702.122340824471, 11708.238964467453, 11709.765804683859, 694857.0, 700600.0, 705776.0, 707780.0, 714789.0, 114571.0, 120941.0, 121048.39475802565, 121091.0, 122344.0, 1020.2450186861669, 1127.0420142878488, 1140.880207578209, 1146.896779289868, 1147.9598214062635, 19093.90453047726, 19951.401457956286, 20018.099185536394, 20053.39839804808, 20104.49738756543, 51274.487255128464, 53027.0, 53372.73313633407, 53764.193537096195, 53940.460595393546, 57889.0, 75068.62465687856, 79380.0, 79704.0, 81876.59061704653, 8190.549519776469, 8344.87482687748, 8449.02836173848, 8516.659333626585, 8567.785805354915, 12568.497260109492, 13554.93222533881, 13724.65688357759, 14033.877289816586, 14036.0, 11496.195266331277, 11640.708982275171, 11824.467898944396, 11871.109666774853, 11971.64085077449, 11516.251443656136, 11691.064714822964, 11742.765144696887, 11908.702282443008, 12092.395380230777, 11832.467538960595, 11987.0, 12031.398430078636, 12167.39163041862, 12216.694582635506, 7954.681812727426, 8107.797305067421, 8345.123762004901, 8449.87325190135, 8812.867806982773, 8503.74488765338, 10906.400147991937, 11924.403779810802, 12001.519939202333, 12159.817602736142], "unit": "score", "name": "jquery.html", "value": 9925.812022800921}, {"lowerIsBetter": false, "replicates": [1658.1046235033082, 1668.5578321744736, 2008.9397318080453, 2023.7470316210465, 2075.138817390783, 8531.317494600433, 9168.679096231634, 9333.253339732813, 9583.66457173999, 9603.423794572322, 9336.0, 9368.110029547199, 9370.625174992992, 9503.192228660555, 9539.379940303892, 2579.767820896119, 2596.5845464725694, 2618.986905065472, 2619.541580223463, 2629.3426643339167, 2548.7578680025367, 2607.621894825249, 2612.7517885800817, 2617.0895246470086, 2617.345663584104, 2573.5110329037516, 2577.7937764978756, 2582.3156863431204, 2610.765031147196, 2612.05965852293, 2406.68713067301, 2424.030387844867, 2537.3022418834876, 2567.8459292442512, 2575.4720282342073, 2557.6419301297647, 2558.961615575768, 2581.819272650915, 2587.4178309880313, 2620.868956552184, 8104.270615644561, 9466.479343636098, 9539.14147726708, 9589.136977671973, 9637.807243855084, 4700.858974230779, 4941.728204948727, 5035.471275516092, 5798.739056742456, 6003.27960644721, 3593.1735700788704, 3644.835982380799, 3676.466912297702, 3737.8131093445218, 3752.418375151856, 1066.7653116314398, 1081.302559848901, 1085.3867564825848, 1115.2137742891243, 1118.9552417903274, 11037.668869933916, 12711.173773704772, 12876.549320773822, 12897.935510322483, 13055.151415157985, 5203.479652034842, 5224.92162617561, 5302.840914772563, 5316.73416329182, 5355.116405793078, 9530.0, 11091.279066860629, 11194.048505877092, 11199.832002519968, 11210.383428911487, 5791.8552036199435, 5904.5571582131515, 5927.4665280125, 6013.368596297326, 6025.246844144482, 4723.126221649006, 5136.717480538607, 5204.375474943031, 5270.973645131749, 5351.973240133774, 4180.916381672349, 4266.975925777853, 4273.358996150602, 4280.379344994958, 4281.850135245251, 1261.0605099201155, 1377.2769296119618, 1381.295539274977, 1403.1440821099122, 1411.0475429085327, 1416.46174453709, 1429.221074514392, 1447.131720967432, 1451.0713143588112, 1473.300182413345, 8547.914520854712, 8742.694005709769, 8764.079771624016, 8770.035296117421, 8779.561021948877, 539.9649022813504, 550.7741825851382, 554.1936482418072, 554.9139883318093, 556.6882545774379, 6518.250401203923, 6531.640759758164, 6593.571417857824, 6611.63636000015, 6625.469962403093, 11236.606718764804, 11625.24435911663, 11642.359670218219, 11726.237794543327, 11739.47172377245, 11123.610673626385, 11465.140114491447, 11500.424978751029, 11516.366599837089, 11632.243904146204, 8840.292776577859, 8854.64581416749, 8929.553522323858, 9013.63945442188, 9105.271578273721, 8433.83132337362, 8452.112528184452, 8648.264897483785, 8652.480851148952, 8661.177188167114, 9928.900710993086, 10144.746381340525, 10265.486725663537, 10265.9486702569, 10268.486575671037, 10301.690949271533, 10383.792324153626, 10549.89450105489, 10585.364878107339, 10689.251752377259, 7894.0, 8470.449420787629, 8676.392652514263, 8696.086910874266, 8855.468671879707, 8804.647814087364, 8813.25087367581, 8816.647334106563, 8853.468791872509, 8894.73315800527, 7599.088109426904, 7643.656035478528, 7758.0, 7920.366370690215, 7988.600569971594, 6761.256261811295, 7290.307420795016, 7601.239876012354, 7642.312191902755, 7801.258880406579, 8037.517748935083, 8134.87797683047, 8139.511629302261, 8160.183981601793, 8199.057108432367, 7212.062431883822, 7339.6330183489545, 7378.7786366406945, 7398.852022959403, 7426.74006409773, 7552.433567482571, 7559.0, 7613.9238607613215, 7620.771376858703, 7629.504082234859], "unit": "score", "name": "mootools.html", "value": 5162.618006895218}, {"lowerIsBetter": false, "replicates": [341.56621091214157, 344.7552237911083, 346.2227299712147, 350.05485189987036, 352.2286193236813, 7041.50709450338, 7050.4007159391385, 7072.575645461263, 7087.68105435256, 7108.1470223573115, 6968.442524598033, 6978.162620485549, 6986.126734158231, 7006.334398232172, 7020.473464490158, 4909.116359055369, 4984.202527595586, 5087.236914462842, 5087.414947281054, 5166.5866730661555, 4146.8963275918195, 4391.451068616423, 4651.3720647712635, 5105.948940510584, 5112.054269960069, 4565.840195593155, 4827.662063655545, 5004.8999020019755, 5031.2453132030305, 5052.343195384595, 5026.648134630559, 5026.849194524152, 5052.8484145475695, 5054.140796064659, 5067.721275329855, 4379.1022840317655, 4379.926917905102, 4388.802503887333, 4393.714408563465, 4404.0, 6451.645159516224, 6700.731970721165, 6781.593104413701, 6781.694823732944, 6831.146106736658, 4965.354503914468, 5826.388229235911, 5879.353271140171, 5923.970380148072, 5934.8813023739285, 7445.553266804009, 7458.776236712907, 7464.589447580381, 7494.437917156235, 7581.469297149201, 4801.927971080437, 4818.614510839125, 4827.710337379768, 4835.540623640749, 4836.274558816171, 7174.246704096047, 7902.960485197537, 7935.523868567847, 7965.721199757981, 7968.52188868664, 4738.834140805125, 4763.118823017753, 4811.879703007453, 4818.229083346648, 4823.1800593899125, 4906.31311616374, 4912.214045752734, 4919.311296418504, 4923.286123512143, 4926.950730492649, 5905.0, 5941.970290148608, 5950.940490595039, 5966.880662386815, 5978.820635380858, 7564.697412103455, 7584.54492730438, 7588.392928565812, 7597.734079307198, 7608.125065617525, 1442.8052212951118, 1632.934682612706, 1669.5325308913523, 1675.6146086399951, 1702.2765324736938, 954.6229239450378, 1087.0108201536564, 1105.3478447715725, 1108.2187058124002, 1110.7389763405592, 6945.40964018054, 6956.582605043714, 6988.615626140509, 6991.335823096798, 6998.810202265627, 7802.68789248435, 7806.960965195138, 7816.960915195387, 7819.296263336327, 7823.943767591302, 6921.377076063179, 6936.2023367312395, 6972.860542789116, 6973.825654358681, 6980.127484064492, 4016.578259282792, 4092.672586193157, 4122.773247471418, 4127.938080928789, 4136.4415803866095, 7109.791335472982, 7808.336291415293, 8149.103598604149, 8176.509409435453, 8217.465864718773, 8171.79570510742, 8176.754697359089, 8182.263596276363, 8183.795405114801, 8189.549574773326, 6728.932710672831, 8234.711785087493, 8239.052508961426, 8259.174082591693, 8277.089520152658, 7626.885596716164, 7844.4116691247245, 7884.329831964347, 7923.881141782763, 7931.682732690628, 6262.812115636538, 7775.14473407936, 7775.961120194363, 7793.64928578204, 7813.570253636105, 8218.958905205436, 8222.62998165096, 8224.218699223564, 8231.506109633201, 8261.752147435587, 4406.845760398371, 5086.847394578169, 5092.083424983539, 5160.148575485153, 5180.61145414103, 5956.761729530944, 6812.182538095262, 7526.5860377679755, 7563.0, 7828.021497312836, 7434.814129646802, 7560.130584982798, 7626.694932202871, 7636.656350464354, 7650.273224043707, 7564.243575642392, 7607.0, 7607.695692172472, 7618.619069046415, 7641.961790191236, 7445.0, 7447.441441891988, 7452.0, 7455.142658594114, 7462.253774622494, 7414.406847452299, 7507.512011719221, 7608.467407281437, 7618.504797188165, 7626.474705059121, 7422.220666829905, 7426.777196684108, 7435.739749108971, 7445.9627701861145, 7478.6260686966525], "unit": "score", "name": "prototype.html", "value": 5434.345937076478}, {"lowerIsBetter": false, "replicates": [727.1819203396178, 752.7892190186747, 759.3848982324317, 770.1836053782987, 781.4061313401817, 14924.776128358084, 15005.0, 15201.467948621801, 15377.923110384447, 15410.306536205855, 14036.228007459586, 14061.015728898981, 14068.648283792885, 14073.437062517512, 14077.366518506666, 783.576868491017, 958.4345236310576, 972.3776782858976, 987.5457289646771, 999.5901680311038, 953.7377221264138, 967.8790151231096, 986.9242525647044, 990.1929927109383, 996.5515518016886, 1016.4612755239698, 1036.4662198967537, 1057.783154453339, 1059.1315121600292, 1060.512164404375, 997.4464172384323, 1031.6543957774154, 1038.2368958815264, 1050.3120456101267, 1052.221356196413, 692.9376356127973, 755.4711701808756, 768.5311959704576, 784.3137254901961, 784.901887264092, 14989.400423983028, 15051.849481505154, 15272.541823745305, 15286.082835029934, 15331.540053798404, 12082.0, 12809.0, 13031.674208144777, 13033.15284506504, 13225.73548529024, 10158.542865570993, 10362.27464077515, 10382.480875956171, 10537.315074520131, 10549.84175237372, 3696.131409118855, 3743.6630703236565, 4181.351890456984, 4362.280223763075, 4384.714993525411, 67286.99069513961, 79643.20356796416, 82056.0, 83645.0, 85115.0, 9941.40351578893, 10020.498975051218, 10033.39799612011, 10177.949110254402, 10229.437380943971, 23057.962391692414, 23247.7675223249, 23523.41191470227, 24207.878960605085, 24520.509589808105, 7613.6573854176695, 7638.847223055619, 7714.228577142353, 7715.267049630276, 7724.0731112266885, 4113.382992551141, 4140.855070072533, 4168.624823765876, 4170.311898536768, 4198.6221240088535, 3667.963320366762, 3718.1076541630355, 3721.6464435878547, 3730.0488375464624, 3743.868964586281, 645.1484041065842, 667.4026746062248, 668.4318329420051, 668.8428219368444, 669.5614372585964, 542.896849598575, 588.3616276340133, 603.7221297261555, 607.6536374266714, 616.7748771698298, 8337.916620833714, 8582.87125693115, 8602.18279263469, 8603.612837422332, 8793.780155496035, 521.1089037745422, 610.1214251477858, 631.8988961766096, 639.6226226526372, 640.0942666127471, 3879.6120387960977, 3962.385830196324, 4052.696047796368, 4061.593840615974, 4169.7453819271095, 97520.0, 97927.53108703376, 99912.0, 100192.0, 100861.0, 82133.58933205415, 82227.5888620553, 82591.58704206561, 82695.0, 83345.0, 60668.0, 76248.23751762412, 76268.0, 76813.84779228205, 77164.61417692875, 7952.6421311042295, 8210.58947052657, 8248.876266856121, 8332.16678332162, 8352.540610266493, 46552.53447465482, 46570.6028819136, 47375.52624473711, 48030.27954580754, 49800.50199497959, 63367.6831615839, 66419.33580664132, 68836.31163688499, 70216.64891675509, 74953.62523187349, 9774.462404567532, 11319.830202546804, 11356.54573817038, 11570.0, 11576.24754390962, 12176.634700958986, 12188.024958003161, 12227.816582751444, 12300.446479908247, 13247.337633118499, 11858.34779087124, 11965.700857478632, 12011.579594714143, 12283.201591896499, 12300.692482688004, 11670.241434306743, 12151.696207594881, 12163.331016794162, 12175.025997920322, 12192.902638762554, 10099.495025248854, 11667.941660291644, 12125.75748485043, 12133.272003679807, 12179.39103044862, 9476.57355418994, 9686.951565242129, 9786.363886347364, 10052.69841904744, 10146.441945693057, 9851.950740246253, 9934.850977235492, 9958.0, 9968.950155249468, 10019.0], "unit": "score", "name": "yui.html", "value": 7193.015280969573}], "name": "dromaeo_css", "value": 7839.456667716134}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [156.0, 155.0, 160.0, 115.0, 117.0, 129.0, 115.0, 112.0, 123.0, 114.0], "unit": "score", "name": "ai-astar", "value": 129.6}, {"lowerIsBetter": true, "replicates": [147.0, 120.0, 141.0, 147.0, 123.0, 161.0, 121.0, 152.0, 146.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 137.8}, {"lowerIsBetter": true, "replicates": [195.0, 195.0, 196.0, 199.0, 243.0, 194.0, 194.0, 193.0, 202.0, 200.0], "unit": "score", "name": "audio-dft", "value": 201.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 73.0, 112.0, 56.0, 55.0, 58.0, 58.0, 112.0, 55.0], "unit": "score", "name": "audio-fft", "value": 71.6}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 113.0, 79.0, 80.0, 78.0, 115.0, 78.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 90.3}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 88.0, 84.0, 91.0, 122.0, 88.0, 87.0, 88.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 95.0, 98.0, 98.0, 88.0, 141.0], "unit": "score", "name": "imaging-darkroom", "value": 98.8}, {"lowerIsBetter": true, "replicates": [118.0, 88.0, 145.0, 139.0, 90.0, 88.0, 91.0, 91.0, 94.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 103.6}, {"lowerIsBetter": true, "replicates": [53.0, 60.0, 60.0, 59.0, 58.0, 57.0, 65.0, 83.0, 57.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 70.0, 64.0, 73.0, 68.0, 69.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [95.0, 111.0, 99.0, 84.0, 83.0, 81.0, 81.0, 83.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.6}, {"lowerIsBetter": true, "replicates": [131.0, 118.0, 132.0, 135.0, 125.0, 135.0, 136.0, 131.0, 121.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.1}, {"lowerIsBetter": true, "replicates": [138.0, 136.0, 132.0, 136.0, 131.0, 129.0, 134.0, 136.0, 133.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 88.0, 91.0, 95.0, 73.0, 66.0, 65.0, 68.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.4}], "name": "kraken", "value": 1479.1}]} 12:02:54 INFO - Return code: 0 12:02:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:02:54 ERROR - # TBPL SUCCESS # 12:02:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:02:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:02:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:02:54 INFO - 2016-03-14 12:02:54.296 screenresolution[1683:10348] starting screenresolution argv=screenresolution get 12:02:54 INFO - 2016-03-14 12:02:54.299 screenresolution[1683:10348] Display 0: 1600x1200x32@60 12:02:54 INFO - 2016-03-14 12:02:54.305 screenresolution[1684:10351] starting screenresolution argv=screenresolution list 12:02:54 INFO - Available Modes on Display 0 12:02:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:02:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:02:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:02:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:02:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:02:54 INFO - Intel Iris: 12:02:54 INFO - Chipset Model: Intel Iris 12:02:54 INFO - Type: GPU 12:02:54 INFO - Bus: Built-In 12:02:54 INFO - VRAM (Dynamic, Max): 1536 MB 12:02:54 INFO - Vendor: Intel (0x8086) 12:02:54 INFO - Device ID: 0x0a2e 12:02:54 INFO - Revision ID: 0x0009 12:02:54 INFO - Displays: 12:02:54 INFO - Display: 12:02:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:02:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:02:54 INFO - Display Serial Number: 1600x1200 60 12:02:54 INFO - Main Display: Yes 12:02:54 INFO - Mirror: Off 12:02:54 INFO - Online: Yes 12:02:54 INFO - Rotation: Supported 12:02:54 INFO - Return code: 0 12:02:54 INFO - Running post-action listener: _resource_record_post_action 12:02:54 INFO - Running post-run listener: _resource_record_post_run 12:02:55 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37250560; Write bytes: 663278592; Read time: 391; Write time: 1823 12:02:55 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362064384; Write bytes: 362722816; Read time: 28137; Write time: 668 12:02:55 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 35427840; Write bytes: 299707904; Read time: 372; Write time: 1153 12:02:55 INFO - Running post-run listener: _upload_blobber_files 12:02:55 INFO - Blob upload gear active. 12:02:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:02:55 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 12:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:02:56 INFO - (blobuploader) - INFO - Open directory for files ... 12:02:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:02:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:57 INFO - (blobuploader) - INFO - Done attempting. 12:02:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:02:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:02:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:58 INFO - (blobuploader) - INFO - Done attempting. 12:02:58 INFO - (blobuploader) - INFO - Iteration through files over. 12:02:58 INFO - Return code: 0 12:02:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:02:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:02:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a6bfc4b29cf84e6e267599becc1de0d55d7cdb2aa049d4ac8147c6b7dfb6a7002ca64de349eafe414a97b21d7557a57914ddbac415d0e62b37e4c63cf2de476", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0bbb65e674ef81c4948f2bce3a6f8a6596258208dde351f3944b293bbcd511ac410710863307ee42a0f8878f2c9a2c9c5cdf28dfad41ba656ff59ac62d4416f"} 12:02:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:02:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:02:58 INFO - Contents: 12:02:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a6bfc4b29cf84e6e267599becc1de0d55d7cdb2aa049d4ac8147c6b7dfb6a7002ca64de349eafe414a97b21d7557a57914ddbac415d0e62b37e4c63cf2de476", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0bbb65e674ef81c4948f2bce3a6f8a6596258208dde351f3944b293bbcd511ac410710863307ee42a0f8878f2c9a2c9c5cdf28dfad41ba656ff59ac62d4416f"} 12:02:58 INFO - Running post-run listener: copy_logs_to_upload_dir 12:02:58 INFO - Copying logs to upload dir... 12:02:58 INFO - mkdir: /builds/slave/test/build/upload/logs 12:02:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.526033 ========= master_lag: 95.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 35 secs) (at 2016-03-14 12:04:33.723564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 22 secs) (at 2016-03-14 12:04:33.724659) ========= 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.YvkxD5yiaG/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.GCisalq8Ni/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a6bfc4b29cf84e6e267599becc1de0d55d7cdb2aa049d4ac8147c6b7dfb6a7002ca64de349eafe414a97b21d7557a57914ddbac415d0e62b37e4c63cf2de476", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0bbb65e674ef81c4948f2bce3a6f8a6596258208dde351f3944b293bbcd511ac410710863307ee42a0f8878f2c9a2c9c5cdf28dfad41ba656ff59ac62d4416f"} build_url:https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/U-Akuqt9RymcoTHEh_5ESQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a6bfc4b29cf84e6e267599becc1de0d55d7cdb2aa049d4ac8147c6b7dfb6a7002ca64de349eafe414a97b21d7557a57914ddbac415d0e62b37e4c63cf2de476", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0bbb65e674ef81c4948f2bce3a6f8a6596258208dde351f3944b293bbcd511ac410710863307ee42a0f8878f2c9a2c9c5cdf28dfad41ba656ff59ac62d4416f"}' ========= master_lag: 22.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 22 secs) (at 2016-03-14 12:04:56.185422) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-03-14 12:04:56.185809) ========= 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.YvkxD5yiaG/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.GCisalq8Ni/Listeners TMPDIR=/var/folders/r9/65qs5nfd3vb9c3mfq0_swnf400000w/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.005883 ========= master_lag: 3.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-03-14 12:04:59.280243) ========= ========= Started reboot skipped (results: 3, elapsed: 2 mins, 10 secs) (at 2016-03-14 12:04:59.280513) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 mins, 10 secs) (at 2016-03-14 12:07:09.361831) ========= ========= Total master_lag: 121.35 =========