builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0050 starttime: 1458847580.62 results: success (0) buildid: 20160324090507 builduid: b99f4408608a478f8904401f53684615 revision: 2d81f8a108e1f4da2bcb14f086649baeebed53a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 12:26:20.622835) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 12:26:20.623275) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 12:26:20.623975) ========= 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.GgXW74MXVG/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.wSendC4qe4/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005343 basedir: '/builds/slave/test' ========= master_lag: 0.14 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 12:26:20.773896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2016-03-24 12:26:20.774271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2016-03-24 12:26:39.718348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2016-03-24 12:26:39.722698) ========= 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.GgXW74MXVG/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.wSendC4qe4/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.006389 ========= master_lag: 11.68 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 11 secs) (at 2016-03-24 12:26:51.407057) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 12:26:51.407407) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 12:26:51.407776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-24 12:26:51.408046) ========= 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.GgXW74MXVG/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.wSendC4qe4/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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-24 12:26:51-- 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% 11.2M=0.001s 2016-03-24 12:26:52 (11.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.534131 ========= master_lag: 1.93 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-24 12:26:53.869168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-03-24 12:26:53.873557) ========= 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.GgXW74MXVG/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.wSendC4qe4/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.026945 ========= master_lag: 7.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-03-24 12:27:00.919986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 17 secs) (at 2016-03-24 12:27:00.920348) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2d81f8a108e1f4da2bcb14f086649baeebed53a2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2d81f8a108e1f4da2bcb14f086649baeebed53a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GgXW74MXVG/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.wSendC4qe4/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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-24 12:27:04,589 truncating revision to first 12 chars 2016-03-24 12:27:04,590 Setting DEBUG logging. 2016-03-24 12:27:04,590 attempt 1/10 2016-03-24 12:27:04,590 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2d81f8a108e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 12:27:05,028 unpacking tar archive at: fx-team-2d81f8a108e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716661 ========= master_lag: 17.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 17 secs) (at 2016-03-24 12:27:18.843366) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 8 secs) (at 2016-03-24 12:27:18.843716) ========= echo 2d81f8a108e1f4da2bcb14f086649baeebed53a2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2d81f8a108e1f4da2bcb14f086649baeebed53a2'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GgXW74MXVG/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.wSendC4qe4/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 2d81f8a108e1f4da2bcb14f086649baeebed53a2 program finished with exit code 0 elapsedTime=0.005843 script_repo_revision: '2d81f8a108e1f4da2bcb14f086649baeebed53a2' ========= master_lag: 8.95 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 8 secs) (at 2016-03-24 12:27:27.801204) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 24 secs) (at 2016-03-24 12:27:27.801533) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 24 secs) (at 2016-03-24 12:27:51.979808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-03-24 12:27:51.980088) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GgXW74MXVG/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.wSendC4qe4/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 12:27:52 INFO - MultiFileLogger online at 20160324 12:27:52 in /builds/slave/test 12:27:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:27:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:27:52 INFO - {'append_to_log': False, 12:27:52 INFO - 'base_work_dir': '/builds/slave/test', 12:27:52 INFO - 'blob_upload_branch': 'Fx-Team', 12:27:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:27:52 INFO - 'branch': 'Fx-Team', 12:27:52 INFO - 'buildbot_json_path': 'buildprops.json', 12:27:52 INFO - 'config_files': ('talos/mac_config.py',), 12:27:52 INFO - 'default_actions': ('clobber', 12:27:52 INFO - 'read-buildbot-config', 12:27:52 INFO - 'download-and-extract', 12:27:52 INFO - 'populate-webroot', 12:27:52 INFO - 'create-virtualenv', 12:27:52 INFO - 'install', 12:27:52 INFO - 'run-tests'), 12:27:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:27:52 INFO - 'download_minidump_stackwalk': True, 12:27:52 INFO - 'download_symbols': 'ondemand', 12:27:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:27:52 INFO - 'tooltool.py': '/tools/tooltool.py', 12:27:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:27:52 INFO - '/tools/misc-python/virtualenv.py')}, 12:27:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:27:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:27:52 INFO - 'installer_path': 'installer.exe', 12:27:52 INFO - 'log_level': 'info', 12:27:52 INFO - 'log_name': 'talos', 12:27:52 INFO - 'log_to_console': True, 12:27:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:27:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:27:52 INFO - 'opt_config_files': (), 12:27:52 INFO - 'pip_index': False, 12:27:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:27:52 INFO - 'cmd': ('bash', 12:27:52 INFO - '-c', 12:27:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:27:52 INFO - 'enabled': True, 12:27:52 INFO - 'halt_on_failure': False, 12:27:52 INFO - 'name': 'check_screen_resolution'},), 12:27:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:27:52 INFO - 'cmd': ('bash', 12:27:52 INFO - '-c', 12:27:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:27:52 INFO - 'enabled': True, 12:27:52 INFO - 'halt_on_failure': False, 12:27:52 INFO - 'name': 'check_screen_resolution'},), 12:27:52 INFO - 'run_cmd_checks_enabled': True, 12:27:52 INFO - 'sps_profile': False, 12:27:52 INFO - 'sps_profile_interval': 0, 12:27:52 INFO - 'suite': 'dromaeojs-e10s', 12:27:52 INFO - 'system_bits': '32', 12:27:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:27:52 INFO - 'title': 't-yosemite-r7-0050', 12:27:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:27:52 INFO - 'use_talos_json': True, 12:27:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:27:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:27:52 INFO - 'work_dir': 'build'} 12:27:52 INFO - ##### 12:27:52 INFO - ##### Running clobber step. 12:27:52 INFO - ##### 12:27:52 INFO - Running pre-action listener: _resource_record_pre_action 12:27:52 INFO - Running main action method: clobber 12:27:52 INFO - rmtree: /builds/slave/test/build 12:27:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:27:54 INFO - Running post-action listener: _resource_record_post_action 12:27:54 INFO - ##### 12:27:54 INFO - ##### Running read-buildbot-config step. 12:27:54 INFO - ##### 12:27:54 INFO - Running pre-action listener: _resource_record_pre_action 12:27:54 INFO - Running main action method: read_buildbot_config 12:27:54 INFO - Using buildbot properties: 12:27:54 INFO - { 12:27:54 INFO - "project": "", 12:27:54 INFO - "product": "firefox", 12:27:54 INFO - "script_repo_revision": "production", 12:27:54 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 12:27:54 INFO - "repository": "", 12:27:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 12:27:54 INFO - "buildid": "20160324090507", 12:27:54 INFO - "pgo_build": "False", 12:27:54 INFO - "basedir": "/builds/slave/test", 12:27:54 INFO - "buildnumber": 636, 12:27:54 INFO - "slavename": "t-yosemite-r7-0050", 12:27:54 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:27:54 INFO - "platform": "yosemite_r7", 12:27:54 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 12:27:54 INFO - "branch": "fx-team", 12:27:54 INFO - "repo_path": "integration/fx-team", 12:27:54 INFO - "revision": "2d81f8a108e1f4da2bcb14f086649baeebed53a2", 12:27:54 INFO - "stage_platform": "macosx64", 12:27:54 INFO - "builduid": "b99f4408608a478f8904401f53684615", 12:27:54 INFO - "slavebuilddir": "test" 12:27:54 INFO - } 12:27:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 12:27:54 INFO - Running post-action listener: _resource_record_post_action 12:27:54 INFO - ##### 12:27:54 INFO - ##### Running download-and-extract step. 12:27:54 INFO - ##### 12:27:54 INFO - Running pre-action listener: _resource_record_pre_action 12:27:54 INFO - Running main action method: download_and_extract 12:27:54 INFO - mkdir: /builds/slave/test/build/tests 12:27:54 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')]} 12:27:54 INFO - https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 12:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 12:27:54 INFO - Downloaded 1199 bytes. 12:27:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 12:27:54 INFO - Using the following test package requirements: 12:27:54 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:27:54 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:27:54 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 12:27:54 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:27:54 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 12:27:54 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:27:54 INFO - u'jsshell-mac.zip'], 12:27:54 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:27:54 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 12:27:54 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:27:54 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:27:54 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 12:27:54 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:27:54 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 12:27:54 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:27:54 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 12:27:54 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:27:54 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 12:27:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:27:54 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')]} 12:27:54 INFO - https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:27:56 INFO - Downloaded 17926963 bytes. 12:27:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:27:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:27:59 INFO - Return code: 0 12:27:59 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:27:59 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')]} 12:27:59 INFO - https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:27:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:27:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:27:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:28:01 INFO - Downloaded 17926963 bytes. 12:28:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:28:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:28:04 INFO - Return code: 0 12:28:04 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')]} 12:28:04 INFO - https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:28:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:28:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:28:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:28:05 INFO - Downloaded 10847187 bytes. 12:28:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:28:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:28:06 INFO - Return code: 0 12:28: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')]} 12:28:06 INFO - https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:28:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:28:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:28:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 12:28:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 12:28:13 INFO - Downloaded 111327283 bytes. 12:28:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:28:13 INFO - mkdir: /builds/slave/test/properties 12:28:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:28:13 INFO - Writing to file /builds/slave/test/properties/build_url 12:28:13 INFO - Contents: 12:28:13 INFO - build_url:https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:28:14 INFO - Running post-action listener: _resource_record_post_action 12:28:14 INFO - Running post-action listener: set_extra_try_arguments 12:28:14 INFO - ##### 12:28:14 INFO - ##### Running populate-webroot step. 12:28:14 INFO - ##### 12:28:14 INFO - Running pre-action listener: _resource_record_pre_action 12:28:14 INFO - Running main action method: populate_webroot 12:28:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:28:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:28:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:28:14 INFO - '--tppagecycles', 12:28:14 INFO - '7'], 12:28:14 INFO - 'tests': ['tsvgm']}}, 12:28:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:28:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:28:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:28:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:28:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:28:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:28:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:28:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:14 INFO - 'talos_options': ['--e10s'], 12:28:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:28:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:14 INFO - 'tests': ['damp', 'tps']}, 12:28:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:14 INFO - 'talos_options': ['--e10s'], 12:28:14 INFO - 'tests': ['damp', 'tps']}, 12:28:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:28:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:28:14 INFO - 'other': {'tests': ['a11yr', 12:28:14 INFO - 'ts_paint', 12:28:14 INFO - 'tpaint', 12:28:14 INFO - 'sessionrestore', 12:28:14 INFO - 'sessionrestore_no_auto_restore', 12:28:14 INFO - 'tabpaint']}, 12:28:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:28:14 INFO - 'tests': ['a11yr', 12:28:14 INFO - 'ts_paint', 12:28:14 INFO - 'tpaint', 12:28:14 INFO - 'sessionrestore', 12:28:14 INFO - 'sessionrestore_no_auto_restore', 12:28:14 INFO - 'tabpaint']}, 12:28:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:28:14 INFO - 'tests': ['a11yr', 12:28:14 INFO - 'ts_paint', 12:28:14 INFO - 'tpaint', 12:28:14 INFO - 'sessionrestore', 12:28:14 INFO - 'sessionrestore_no_auto_restore', 12:28:14 INFO - 'tabpaint']}, 12:28:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:28:14 INFO - 'tests': ['a11yr', 12:28:14 INFO - 'ts_paint', 12:28:14 INFO - 'tpaint', 12:28:14 INFO - 'sessionrestore', 12:28:14 INFO - 'sessionrestore_no_auto_restore', 12:28:14 INFO - 'tabpaint']}, 12:28:14 INFO - 'other_l64': {'tests': ['a11yr', 12:28:14 INFO - 'ts_paint', 12:28:14 INFO - 'tpaint', 12:28:14 INFO - 'sessionrestore', 12:28:14 INFO - 'sessionrestore_no_auto_restore', 12:28:14 INFO - 'tabpaint']}, 12:28:14 INFO - 'other_nol64': {'tests': ['a11yr', 12:28:14 INFO - 'ts_paint', 12:28:14 INFO - 'tpaint', 12:28:14 INFO - 'sessionrestore', 12:28:14 INFO - 'sessionrestore_no_auto_restore', 12:28:14 INFO - 'tabpaint']}, 12:28:14 INFO - 'svgr': {'tests': ['tsvgx', 12:28:14 INFO - 'tsvgr_opacity', 12:28:14 INFO - 'tart', 12:28:14 INFO - 'tscrollx', 12:28:14 INFO - 'cart']}, 12:28:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:28:14 INFO - 'tests': ['tsvgx', 12:28:14 INFO - 'tsvgr_opacity', 12:28:14 INFO - 'tart', 12:28:14 INFO - 'tscrollx', 12:28:14 INFO - 'cart']}, 12:28:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:14 INFO - 'tests': ['tp5o']}, 12:28:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:14 INFO - 'talos_options': ['--e10s'], 12:28:14 INFO - 'tests': ['tp5o']}, 12:28:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:14 INFO - 'talos_options': ['--xperf_path', 12:28:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:28:14 INFO - 'tests': ['tp5n']}, 12:28:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:14 INFO - 'talos_options': ['--e10s', 12:28:14 INFO - '--xperf_path', 12:28:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:28:14 INFO - 'tests': ['tp5n']}}, 12:28:14 INFO - 'talos.zip': {'path': '', 12:28:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:28:14 INFO - Running post-action listener: _resource_record_post_action 12:28:14 INFO - ##### 12:28:14 INFO - ##### Running create-virtualenv step. 12:28:14 INFO - ##### 12:28:14 INFO - Running pre-action listener: _resource_record_pre_action 12:28:14 INFO - Running main action method: create_virtualenv 12:28:14 INFO - Creating virtualenv /builds/slave/test/build/venv 12:28:14 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 12:28:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:28:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:28:14 INFO - Using real prefix '/tools/python27' 12:28:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:28:15 INFO - Installing distribute.............................................................................................................................................................................................done. 12:28:18 INFO - Installing pip.................done. 12:28:18 INFO - Return code: 0 12:28:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:28:18 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')]} 12:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:18 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')]} 12:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:18 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 0x1098a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d2c9d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109740e00>, '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 0x1095a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10973bb20>, '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.GgXW74MXVG/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.wSendC4qe4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 12:28:18 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 12:28:18 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 12:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgXW74MXVG/Render', 12:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:18 INFO - 'HOME': '/Users/cltbld', 12:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:18 INFO - 'LOGNAME': 'cltbld', 12:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:18 INFO - 'MOZ_NO_REMOTE': '1', 12:28:18 INFO - 'NO_EM_RESTART': '1', 12:28:18 INFO - 'PAGER': '/bin/cat', 12:28:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:18 INFO - 'PWD': '/builds/slave/test', 12:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:18 INFO - 'SHELL': '/bin/bash', 12:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSendC4qe4/Listeners', 12:28:18 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 12:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:18 INFO - 'USER': 'cltbld', 12:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:18 INFO - 'XPC_FLAGS': '0x0', 12:28:18 INFO - 'XPC_SERVICE_NAME': '0', 12:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:18 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 12:28:18 INFO - Cleaning up... 12:28:18 INFO - Return code: 0 12:28:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:28:18 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')]} 12:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:18 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')]} 12:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:18 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 0x1098a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d2c9d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109740e00>, '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 0x1095a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10973bb20>, '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.GgXW74MXVG/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.wSendC4qe4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 12:28:18 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 12:28:18 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 12:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgXW74MXVG/Render', 12:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:18 INFO - 'HOME': '/Users/cltbld', 12:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:18 INFO - 'LOGNAME': 'cltbld', 12:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:18 INFO - 'MOZ_NO_REMOTE': '1', 12:28:18 INFO - 'NO_EM_RESTART': '1', 12:28:18 INFO - 'PAGER': '/bin/cat', 12:28:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:18 INFO - 'PWD': '/builds/slave/test', 12:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:18 INFO - 'SHELL': '/bin/bash', 12:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSendC4qe4/Listeners', 12:28:18 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 12:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:18 INFO - 'USER': 'cltbld', 12:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:18 INFO - 'XPC_FLAGS': '0x0', 12:28:18 INFO - 'XPC_SERVICE_NAME': '0', 12:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:18 INFO - Downloading/unpacking psutil>=0.7.1 12:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:28:21 INFO - Installing collected packages: psutil 12:28:21 INFO - Running setup.py install for psutil 12:28:21 INFO - building 'psutil._psutil_osx' extension 12:28:21 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 12:28:22 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 12:28:22 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 12:28:22 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 12:28:22 INFO - building 'psutil._psutil_posix' extension 12:28:22 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 12:28:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:28:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:28:22 INFO - ^ 12:28:22 INFO - 1 warning generated. 12:28:22 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 12:28:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:28:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:28:22 INFO - Successfully installed psutil 12:28:22 INFO - Cleaning up... 12:28:23 INFO - Return code: 0 12:28:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:28: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')]} 12:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28: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')]} 12:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1098a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d2c9d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109740e00>, '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 0x1095a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10973bb20>, '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.GgXW74MXVG/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.wSendC4qe4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 12:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:28:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgXW74MXVG/Render', 12:28:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:23 INFO - 'HOME': '/Users/cltbld', 12:28:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:23 INFO - 'LOGNAME': 'cltbld', 12:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:23 INFO - 'MOZ_NO_REMOTE': '1', 12:28:23 INFO - 'NO_EM_RESTART': '1', 12:28:23 INFO - 'PAGER': '/bin/cat', 12:28:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:23 INFO - 'PWD': '/builds/slave/test', 12:28:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:23 INFO - 'SHELL': '/bin/bash', 12:28:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSendC4qe4/Listeners', 12:28:23 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 12:28:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:23 INFO - 'USER': 'cltbld', 12:28:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:23 INFO - 'XPC_FLAGS': '0x0', 12:28:23 INFO - 'XPC_SERVICE_NAME': '0', 12:28:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:28:25 INFO - Installing collected packages: mozsystemmonitor 12:28:25 INFO - Running setup.py install for mozsystemmonitor 12:28:25 INFO - Successfully installed mozsystemmonitor 12:28:25 INFO - Cleaning up... 12:28:25 INFO - Return code: 0 12:28:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:28:25 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')]} 12:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:25 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')]} 12:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:25 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 0x1098a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d2c9d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109740e00>, '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 0x1095a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10973bb20>, '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.GgXW74MXVG/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.wSendC4qe4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 12:28:25 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 12:28: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 blobuploader==1.2.4 12:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgXW74MXVG/Render', 12:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:26 INFO - 'HOME': '/Users/cltbld', 12:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:26 INFO - 'LOGNAME': 'cltbld', 12:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:26 INFO - 'MOZ_NO_REMOTE': '1', 12:28:26 INFO - 'NO_EM_RESTART': '1', 12:28:26 INFO - 'PAGER': '/bin/cat', 12:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:26 INFO - 'PWD': '/builds/slave/test', 12:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:26 INFO - 'SHELL': '/bin/bash', 12:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSendC4qe4/Listeners', 12:28:26 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 12:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:26 INFO - 'USER': 'cltbld', 12:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:26 INFO - 'XPC_FLAGS': '0x0', 12:28:26 INFO - 'XPC_SERVICE_NAME': '0', 12:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:26 INFO - Downloading/unpacking blobuploader==1.2.4 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:28 INFO - Downloading blobuploader-1.2.4.tar.gz 12:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:28:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:28:28 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 12:28:28 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 12:28:28 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 12:28:28 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 12:28:28 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 12:28:28 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 12:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:28:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:29 INFO - Downloading docopt-0.6.1.tar.gz 12:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:28:29 INFO - Installing collected packages: blobuploader, requests, docopt 12:28:29 INFO - Running setup.py install for blobuploader 12:28:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:28:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:28:30 INFO - Running setup.py install for requests 12:28:30 INFO - Running setup.py install for docopt 12:28:30 INFO - Successfully installed blobuploader requests docopt 12:28:30 INFO - Cleaning up... 12:28:30 INFO - Return code: 0 12:28:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:30 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')]} 12:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:30 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')]} 12:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:30 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 0x1098a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d2c9d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109740e00>, '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 0x1095a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10973bb20>, '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.GgXW74MXVG/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.wSendC4qe4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 12:28:30 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 12:28:30 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 12:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgXW74MXVG/Render', 12:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:30 INFO - 'HOME': '/Users/cltbld', 12:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:30 INFO - 'LOGNAME': 'cltbld', 12:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:30 INFO - 'MOZ_NO_REMOTE': '1', 12:28:30 INFO - 'NO_EM_RESTART': '1', 12:28:30 INFO - 'PAGER': '/bin/cat', 12:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:30 INFO - 'PWD': '/builds/slave/test', 12:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:30 INFO - 'SHELL': '/bin/bash', 12:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSendC4qe4/Listeners', 12:28:30 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 12:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:30 INFO - 'USER': 'cltbld', 12:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:30 INFO - 'XPC_FLAGS': '0x0', 12:28:30 INFO - 'XPC_SERVICE_NAME': '0', 12:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:28:31 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-AiYO7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:28:31 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-ZaFluh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:28:31 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-EWtMKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:28:31 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-3byhg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:28:31 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-ll8ym1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:28:31 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-ZHyGxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:28:31 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-zTvmDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:28:31 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-s3nsc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:28:31 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-kcmunZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:28:31 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-wDj2qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:28:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-OeAGu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:28:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-KNTWXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:28:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-50waTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:28:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Lu_PhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-jVUitH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:28:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-evXHGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:28:32 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-PcH3Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:28:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:28:32 INFO - Running setup.py install for manifestparser 12:28:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:28:32 INFO - Running setup.py install for mozcrash 12:28:33 INFO - Running setup.py install for mozdebug 12:28:33 INFO - Running setup.py install for mozdevice 12:28:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:28:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:28:33 INFO - Running setup.py install for mozfile 12:28:33 INFO - Running setup.py install for mozhttpd 12:28:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:28:33 INFO - Running setup.py install for mozinfo 12:28:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:28:33 INFO - Running setup.py install for mozInstall 12:28:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:28:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:28:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:28:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:28:34 INFO - Running setup.py install for mozleak 12:28:34 INFO - Running setup.py install for mozlog 12:28:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:28:34 INFO - Running setup.py install for moznetwork 12:28:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:28:34 INFO - Running setup.py install for mozprocess 12:28:34 INFO - Running setup.py install for mozprofile 12:28:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:28:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:28:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:28:34 INFO - Running setup.py install for mozrunner 12:28:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:28:34 INFO - Running setup.py install for mozscreenshot 12:28:35 INFO - Running setup.py install for moztest 12:28:35 INFO - Running setup.py install for mozversion 12:28:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:28:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:28:35 INFO - Cleaning up... 12:28:35 INFO - Return code: 0 12:28:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:35 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 0x1098a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d2c9d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109740e00>, '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 0x1095a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10973bb20>, '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.GgXW74MXVG/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.wSendC4qe4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 12:28:35 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 12:28:35 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 12:28:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgXW74MXVG/Render', 12:28:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:35 INFO - 'HOME': '/Users/cltbld', 12:28:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:35 INFO - 'LOGNAME': 'cltbld', 12:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:35 INFO - 'MOZ_NO_REMOTE': '1', 12:28:35 INFO - 'NO_EM_RESTART': '1', 12:28:35 INFO - 'PAGER': '/bin/cat', 12:28:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:35 INFO - 'PWD': '/builds/slave/test', 12:28:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:35 INFO - 'SHELL': '/bin/bash', 12:28:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSendC4qe4/Listeners', 12:28:35 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 12:28:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:35 INFO - 'USER': 'cltbld', 12:28:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:35 INFO - 'XPC_FLAGS': '0x0', 12:28:35 INFO - 'XPC_SERVICE_NAME': '0', 12:28:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:28:35 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-IxQP8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:28:35 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)) 12:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:28:35 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-gjc2dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:28:35 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)) 12:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:28:35 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-U0lpn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:28:36 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)) 12:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:28:36 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Ef6Bfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:28:36 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)) 12:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:28:36 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-HX2JG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:28:36 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)) 12:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:28:36 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-3LYsjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:28:36 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)) 12:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:28:36 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Y5fNE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:28:36 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)) 12:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:28:36 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-_Rp9Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:28:36 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)) 12:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:28:36 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-jw2RaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:28:36 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)) 12:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:28:36 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-JRDVxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:28:36 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)) 12:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:28:36 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-TZ89rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:28:36 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)) 12:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:28:36 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-1PRBAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:28:36 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)) 12:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:28:36 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-WJsGlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:28:37 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)) 12:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:28:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Bz1YH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:28:37 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)) 12:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-ZERiZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:37 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)) 12:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:28:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-TrQWRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:28:37 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)) 12:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:28:37 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-96SDRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:28:37 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)) 12:28:37 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)) 12:28:37 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)) 12:28:37 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)) 12:28:37 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)) 12:28:37 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)) 12:28:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:28:37 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 12:28:37 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 12:28:37 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 12:28:37 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 12:28:37 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 12:28:37 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 12:28:39 INFO - Downloading blessings-1.6.tar.gz 12:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:28:39 INFO - Installing collected packages: blessings 12:28:39 INFO - Running setup.py install for blessings 12:28:40 INFO - Successfully installed blessings 12:28:40 INFO - Cleaning up... 12:28:40 INFO - Return code: 0 12:28:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:28:40 INFO - Reading from file tmpfile_stdout 12:28:40 INFO - Current package versions: 12:28:40 INFO - blessings == 1.6 12:28:40 INFO - blobuploader == 1.2.4 12:28:40 INFO - docopt == 0.6.1 12:28:40 INFO - manifestparser == 1.1 12:28:40 INFO - mozInstall == 1.12 12:28:40 INFO - mozcrash == 0.17 12:28:40 INFO - mozdebug == 0.1 12:28:40 INFO - mozdevice == 0.48 12:28:40 INFO - mozfile == 1.2 12:28:40 INFO - mozhttpd == 0.7 12:28:40 INFO - mozinfo == 0.9 12:28:40 INFO - mozleak == 0.1 12:28:40 INFO - mozlog == 3.1 12:28:40 INFO - moznetwork == 0.27 12:28:40 INFO - mozprocess == 0.22 12:28:40 INFO - mozprofile == 0.28 12:28:40 INFO - mozrunner == 6.11 12:28:40 INFO - mozscreenshot == 0.1 12:28:40 INFO - mozsystemmonitor == 0.0 12:28:40 INFO - moztest == 0.7 12:28:40 INFO - mozversion == 1.4 12:28:40 INFO - psutil == 3.1.1 12:28:40 INFO - requests == 1.2.3 12:28:40 INFO - wsgiref == 0.1.2 12:28:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:40 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')]} 12:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:40 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')]} 12:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:40 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 0x1098a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d2c9d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109740e00>, '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 0x1095a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10973bb20>, '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.GgXW74MXVG/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.wSendC4qe4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 12:28:40 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 12:28:40 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 12:28:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgXW74MXVG/Render', 12:28:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:40 INFO - 'HOME': '/Users/cltbld', 12:28:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:40 INFO - 'LOGNAME': 'cltbld', 12:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:40 INFO - 'MOZ_NO_REMOTE': '1', 12:28:40 INFO - 'NO_EM_RESTART': '1', 12:28:40 INFO - 'PAGER': '/bin/cat', 12:28:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:40 INFO - 'PWD': '/builds/slave/test', 12:28:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:40 INFO - 'SHELL': '/bin/bash', 12:28:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSendC4qe4/Listeners', 12:28:40 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 12:28:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:40 INFO - 'USER': 'cltbld', 12:28:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:40 INFO - 'XPC_FLAGS': '0x0', 12:28:40 INFO - 'XPC_SERVICE_NAME': '0', 12:28:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:40 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)) 12:28:40 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)) 12:28:40 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)) 12:28:40 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)) 12:28:40 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)) 12:28:40 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)) 12:28:40 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)) 12:28:40 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)) 12:28:40 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)) 12:28:40 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)) 12:28:40 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)) 12:28:40 INFO - Cleaning up... 12:28:40 INFO - Return code: 0 12:28:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:28:40 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')]} 12:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:40 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')]} 12:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:40 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 0x1098a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d2c9d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109740e00>, '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 0x1095a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10973bb20>, '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.GgXW74MXVG/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.wSendC4qe4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 12:28:40 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 12:28:40 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 12:28:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgXW74MXVG/Render', 12:28:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:40 INFO - 'HOME': '/Users/cltbld', 12:28:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:40 INFO - 'LOGNAME': 'cltbld', 12:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:40 INFO - 'MOZ_NO_REMOTE': '1', 12:28:40 INFO - 'NO_EM_RESTART': '1', 12:28:40 INFO - 'PAGER': '/bin/cat', 12:28:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:40 INFO - 'PWD': '/builds/slave/test', 12:28:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:40 INFO - 'SHELL': '/bin/bash', 12:28:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSendC4qe4/Listeners', 12:28:40 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 12:28:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:40 INFO - 'USER': 'cltbld', 12:28:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:40 INFO - 'XPC_FLAGS': '0x0', 12:28:40 INFO - 'XPC_SERVICE_NAME': '0', 12:28:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:41 INFO - Downloading/unpacking jsonschema 12:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:28:43 INFO - Downloading/unpacking functools32 (from jsonschema) 12:28:43 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 12:28:43 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 12:28:43 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 12:28:43 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 12:28:43 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 12:28:43 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 12:28:43 INFO - Downloading functools32-3.2.3-2.tar.gz 12:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:28:43 INFO - warning: no files found matching '*.txt' 12:28:43 INFO - no previously-included directories found matching 'build' 12:28:43 INFO - no previously-included directories found matching 'dist' 12:28:43 INFO - no previously-included directories found matching '.git*' 12:28:43 INFO - Installing collected packages: jsonschema, functools32 12:28:43 INFO - Running setup.py install for functools32 12:28:44 INFO - warning: no files found matching '*.txt' 12:28:44 INFO - no previously-included directories found matching 'build' 12:28:44 INFO - no previously-included directories found matching 'dist' 12:28:44 INFO - no previously-included directories found matching '.git*' 12:28:44 INFO - Successfully installed jsonschema functools32 12:28:44 INFO - Cleaning up... 12:28:44 INFO - Return code: 0 12:28:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:28: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')]} 12:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28: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')]} 12:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d2c9d8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109740e00>, '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 0x1095a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10973bb20>, '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.GgXW74MXVG/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.wSendC4qe4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 12:28: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', 'flake8'] in /builds/slave/test/build 12:28: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 flake8 12:28:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgXW74MXVG/Render', 12:28:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:28:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:28:44 INFO - 'HOME': '/Users/cltbld', 12:28:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:28:44 INFO - 'LOGNAME': 'cltbld', 12:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:44 INFO - 'MOZ_NO_REMOTE': '1', 12:28:44 INFO - 'NO_EM_RESTART': '1', 12:28:44 INFO - 'PAGER': '/bin/cat', 12:28:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:44 INFO - 'PWD': '/builds/slave/test', 12:28:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:28:44 INFO - 'SHELL': '/bin/bash', 12:28:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSendC4qe4/Listeners', 12:28:44 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 12:28:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:28:44 INFO - 'USER': 'cltbld', 12:28:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:28:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:44 INFO - 'XPC_FLAGS': '0x0', 12:28:44 INFO - 'XPC_SERVICE_NAME': '0', 12:28:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:44 INFO - Downloading/unpacking flake8 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:28:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:28:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28: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 12:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:28:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:28:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:28:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:28:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:28:47 INFO - no previously-included directories found matching 'docs/_build' 12:28:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:28:48 INFO - Running setup.py install for pep8 12:28:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:28:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:28:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:28:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:28:48 INFO - no previously-included directories found matching 'docs/_build' 12:28:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:28:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:28:48 INFO - Cleaning up... 12:28:48 INFO - Return code: 0 12:28:48 INFO - Running post-action listener: _resource_record_post_action 12:28:48 INFO - Running post-action listener: _start_resource_monitoring 12:28:48 INFO - Starting resource monitoring. 12:28:48 INFO - ##### 12:28:48 INFO - ##### Running install step. 12:28:48 INFO - ##### 12:28:48 INFO - Running pre-action listener: _resource_record_pre_action 12:28:48 INFO - Running main action method: install 12:28:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:28:48 INFO - Reading from file tmpfile_stdout 12:28:48 INFO - Detecting whether we're running mozinstall >=1.0... 12:28:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:28:48 INFO - Reading from file tmpfile_stdout 12:28:48 INFO - Output received: 12:28:48 INFO - Usage: mozinstall [options] installer 12:28:48 INFO - Options: 12:28:48 INFO - -h, --help show this help message and exit 12:28:48 INFO - -d DEST, --destination=DEST 12:28:48 INFO - Directory to install application into. [default: 12:28:48 INFO - "/builds/slave/test"] 12:28:48 INFO - --app=APP Application being installed. [default: firefox] 12:28:48 INFO - mkdir: /builds/slave/test/build/application 12:28:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:29:23 INFO - Reading from file tmpfile_stdout 12:29:23 INFO - Output received: 12:29:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:29:23 INFO - Running post-action listener: _resource_record_post_action 12:29:23 INFO - ##### 12:29:23 INFO - ##### Running run-tests step. 12:29:23 INFO - ##### 12:29:23 INFO - Running pre-action listener: _resource_record_pre_action 12:29:23 INFO - Running main action method: run_tests 12:29:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:29:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:29:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:29:23 INFO - 2016-03-24 12:29:23.723 screenresolution[1650:7734] starting screenresolution argv=screenresolution get 12:29:23 INFO - 2016-03-24 12:29:23.726 screenresolution[1650:7734] Display 0: 1600x1200x32@60 12:29:23 INFO - 2016-03-24 12:29:23.732 screenresolution[1651:7736] starting screenresolution argv=screenresolution list 12:29:23 INFO - Available Modes on Display 0 12:29:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:29:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:29:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:29:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:29:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:29:23 INFO - Intel Iris: 12:29:23 INFO - Chipset Model: Intel Iris 12:29:23 INFO - Type: GPU 12:29:23 INFO - Bus: Built-In 12:29:23 INFO - VRAM (Dynamic, Max): 1536 MB 12:29:23 INFO - Vendor: Intel (0x8086) 12:29:23 INFO - Device ID: 0x0a2e 12:29:23 INFO - Revision ID: 0x0009 12:29:23 INFO - Displays: 12:29:23 INFO - Display: 12:29:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:29:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:29:23 INFO - Display Serial Number: 1600x1200 60 12:29:23 INFO - Main Display: Yes 12:29:23 INFO - Mirror: Off 12:29:23 INFO - Online: Yes 12:29:23 INFO - Rotation: Supported 12:29:23 INFO - Return code: 0 12:29:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:29:23 INFO - Python 2.7.3 12:29:23 INFO - Return code: 0 12:29:23 INFO - grabbing minidump binary from tooltool 12:29: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')]} 12:29: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 0x109740e00>, '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 0x1095a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10973bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:29: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 12:29: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 12:29:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:29:24 INFO - Return code: 0 12:29:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:29:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:29:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:29:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:29:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:29:25 INFO - Return code: 0 12:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 12:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0050 --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 12:29:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GgXW74MXVG/Render', 12:29:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:25 INFO - 'HOME': '/Users/cltbld', 12:29:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:25 INFO - 'LOGNAME': 'cltbld', 12:29:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:29:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:25 INFO - 'MOZ_NO_REMOTE': '1', 12:29:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:29:25 INFO - 'NO_EM_RESTART': '1', 12:29:25 INFO - 'PAGER': '/bin/cat', 12:29:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:25 INFO - 'PWD': '/builds/slave/test', 12:29:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:29:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:25 INFO - 'SHELL': '/bin/bash', 12:29:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSendC4qe4/Listeners', 12:29:25 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 12:29:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:25 INFO - 'USER': 'cltbld', 12:29:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:25 INFO - 'XPC_FLAGS': '0x0', 12:29:25 INFO - 'XPC_SERVICE_NAME': '0', 12:29:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 12:29:25 INFO - mozversion application_buildid: 20160324090507 12:29:25 INFO - mozversion application_changeset: 2d81f8a108e1f4da2bcb14f086649baeebed53a2 12:29:25 INFO - mozversion application_display_name: Nightly 12:29:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:29:25 INFO - mozversion application_name: Firefox 12:29:25 INFO - mozversion application_remotingname: firefox 12:29:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:29:25 INFO - mozversion application_vendor: Mozilla 12:29:25 INFO - mozversion application_version: 48.0a1 12:29:25 INFO - mozversion platform_buildid: 20160324090507 12:29:25 INFO - mozversion platform_changeset: 2d81f8a108e1f4da2bcb14f086649baeebed53a2 12:29:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:29:25 INFO - mozversion platform_version: 48.0a1 12:29:25 INFO - using testdate: 1458847765 12:29:25 INFO - actual date: 1458847765 12:29:25 INFO - starting webserver on 'localhost:49271' 12:29:25 INFO - SUITE-START | Running 2 tests 12:29:25 INFO - TEST-START | dromaeo_css 12:29:25 INFO - operating with platform_type : mac_ 12:29:25 INFO - Initialising browser for dromaeo_css test... 12:29:25 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmp9zU2qx/profile http://localhost:49271/getInfo.html) 12:29:27 INFO - PROCESS | 1669 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 12:29:28 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 12:29:28 INFO - PROCESS | 1669 | colorDepth:24 12:29:28 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 12:29:28 INFO - PROCESS | 1669 | __metrics 12:29:28 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 12:29:29 INFO - TEST-INFO | 1669: exit 0 12:29:29 INFO - Browser initialized. 12:29:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:29:29 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmp9zU2qx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:29:40 INFO - PROCESS | 1674 | RSS: Main: 254660608 12:29:40 INFO - PROCESS | 1674 | 12:30:30 INFO - PROCESS | 1674 | 1458847830579 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] 12:32:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 12:32:42 INFO - PROCESS | 1674 | RSS: Main: 268394496 12:32:42 INFO - PROCESS | 1674 | 12:35:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 12:35:45 INFO - PROCESS | 1674 | RSS: Main: 279023616 12:35:45 INFO - PROCESS | 1674 | 12:38:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 12:38:47 INFO - PROCESS | 1674 | RSS: Main: 281415680 12:38:47 INFO - PROCESS | 1674 | 12:41:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 12:41:49 INFO - PROCESS | 1674 | RSS: Main: 282677248 12:41:49 INFO - PROCESS | 1674 | 12:44:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 12:44:52 INFO - PROCESS | 1674 | RSS: Main: 285454336 12:44:52 INFO - PROCESS | 1674 | 12:47:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 12:47:55 INFO - PROCESS | 1674 | RSS: Main: 286773248 12:47:55 INFO - PROCESS | 1674 | 12:47:55 INFO - PROCESS | 1674 | __start_tp_report 12:47:55 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 12:47:55 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 12:47:55 INFO - PROCESS | 1674 | |i|pagename|runs| 12:47:55 INFO - PROCESS | 1674 | |0;dojo.html;3417.982910085449;3521.8767343142986;3562.358775420425;3578.9463158052636;3608.7113030957526;5789.652620842752;5791.333996590393;5805;5824.534037277018;5853.853653658655;5683.715814209294;5733.226014488043;5789;5817.185594016831;5911;5207.088759467097;5297.12597421425;5305.8938821223555;5344.171653393731;5359.1425371940495;404.2155443357117;5255.277441216751;5310.362756469229;5340.652857564246;5401.000814849246;5259.947400525984;5280.815171469018;5295.761690723907;5317.574594032468;5324.254604355355;5211.218317252443;5333.653312534673;5344.22508736235;5371.650842695212;5392.730363481849;5238.109521381374;5243.10867152585;5307.150855863043;5316.202569614588;5355.732213389315;5628.437156284339;5705.229793977802;5709.45760152789;5718.027935251017;5762.250907382014;6166.722497487579;6259.280182778994;6283.937160628427;6345.904811427832;6348.555601107878;6300.684965751694;6328.050792381179;6344.904826427607;6349.4602958748565;6354.809355719336;5991.850203744898;5992.49063829575;5997.790077347316;6013.639181649115;6026.6986650667295;6271.62370257786;6384.170057892445;6456.9354306456335;6457.031445283245;6457.677116144174;6255.155554000152;6261;6282.246130464374;6294.181756371642;6301.275353334334;6330.620162790247;6333.873322533524;6337.397947195009;6340.936590634127;6361.4592759615025;6181.103739957681;6224.502039836802;6294.779682711083;6321.1150438938585;6358.523110766711;5842.620229685142;6265.937340626535;6336.904946425807;6343.682815859189;6354.332795056545;4400.581944715247;4993.850184494471;5039.722815245197;5049.974750126299;5062.924056139161;3684.5210122684416;3895.474110995036;4396.098799746044;4442.42248507692;4505.7296562206375;5732.566858285429;5781.5952883298605;5947.851303717355;5948;6020.4280593343565;5290.338707661543;6329.746810127635;6329.968350158312;6342.302346741854;6378.968105159537;5846.619969701956;5951.553633477506;5991.940080599138;6050.062240352752;6086.300075491286;4597.95402045982;5404.1353383459245;5451.400345961941;5469.15228139639;5469.535089517356;6351.618902865843;6488.610683359014;6496.740130394731;6510.381513756186;6527.640979746065;6198.0702894566175;6307.842303942254;6330.272018717907;6369.426751592379;6371.458426033653;6463.741450342121;6476.352364763486;6497.675116244074;6504.317046710027;6513.381228783258;6155.538334624832;6233.625982441068;6295.401936815995;6345.555811093179;6356.841078973062;6289.6540690260645;6296.0555916612875;6327.841803954938;6343.90484142729;6344.365563443619;6196.380361963767;6219.160413344322;6314.052892066226;6332.11350410952;6337.493000560036;6139.570230083851;6196.1635179250225;6297.370262973666;6341.239051313872;6343.080253363144;5905.261842269716;6108.847278818065;6133;6153.292371377349;6161.537884658758;6194.884920714315;6278.843028924313;6281.309056003927;6291.307956124731;6292.402221788922;6036.094585812163;6095.664738439428;6198.597091189058;6207.099970504342;6211.65835879013 12:47:55 INFO - PROCESS | 1674 | |1;ext.html;471.36365906026845;509.75786501411835;548.0628125904703;604.295995165632;621.3599992008232;39414.802925985365;40123.799381003126;40177.99555011126;40191.19617607646;40322.59677403229;41518.58481415185;41987.37018944718;42218;42218.15563688724;42301.576984230145;9409.95295023524;9465.81068378632;9557.13985741283;9647.662331818388;9679.419234845931;9547.093026162504;9561.33070685049;9657.46883921384;9662.855057174149;9703.660371886985;9488.952555237214;9607.807843843118;9624.663136790214;9724.173445257162;9731.659391921285;9565.139137477661;9608.039196080406;9612.807743845118;9692.90307096927;9696;8268.958655206745;9549.379290346174;9645.228381729445;9703.369280996783;9773.120419162238;38043.429348559795;38277.043073923094;38666;38900.61099388998;39068;2624.842509449439;3012.834294113823;3197.7921435106646;3386.102682789063;3430.6054803697643;26920.865395672896;26980;27195.72804271952;27751.583726244124;27893.86053069742;2666.186813022047;2668.2662267876294;2694.2994821346592;2714.7149549297433;2924.327404696932;368906;398636.00681996404;413202;416497.91751041356;416966;65925;66782.66608666925;66852;67019.32980670228;67050;68767.96848047283;72793.63603182056;74049.88925166127;76316.61841690868;76384;16470.42353517621;16968.23642936071;16983.575410614587;17148.05685687299;17174.39889603858;12793.360331983364;12851.935740321425;12983.026273029373;13050.086493945333;13056.608301750963;21349.78650213509;21634.02646880894;21949.67075493869;22017.33947981531;22043.00806463713;7747.341475974606;9115.316351273681;9364.15722584957;9380.90619093814;9469.431834089977;947.1522986926662;947.6212111377929;1003.5835128421623;1019.9286049976579;1021.8722659667542;27404.862975684995;29469.26326841846;29877.10368688943;29949.409446870242;30089.69910300869;1084.7721978384627;1099.3184225780067;1105.5798796457455;1131.3494740524068;1147.1167201254987;14896.925515372353;14968.850311496746;14996.850031499545;15206.695866082617;15286.235688215545;738854;741282;750494;751971;757648;59586.51033724105;60787.69606152029;61014.4746381344;61176.69411653002;61222;1501.8798496120285;1510.5317351621034;1511.3954418232795;1514.9242537873283;1551.1468692219235;29982.850085749433;30638.378160982178;30685.53971690471;31538.526922096647;31884.88402905887;51724.74137629288;51910.48089519208;52007;52361.7381913088;52644.21033684421;502925;507089.92910070426;507162;507976;508188;33222.83388583042;33596.83201583976;33953.83023084869;34143.82928085344;34319.65680343265;44958.55041449674;45712.54287457083;45959;46056.8485787858;46600;36542.903712888656;36828;37123.44314835333;37195;37679;36645.45031824578;37244.882653520435;37324;37534.8123259382;38081.4287785689;36572.451413229355;36649.267014660094;36991.630083698816;37185.25629487341;37218.25563488769;28992.710072899845;33758.498344929096;33977;34677.306453871286;34753.304933900676;23130.421739456648;24398;24591;24734.763261836477;24858.627120592842 12:47:55 INFO - PROCESS | 1674 | |2;jquery.html;303.3780749463599;353.7028895727588;357.5137812574898;362.5812186924102;368.03574634457726;19183.712244316346;19673.42612590993;19973.10121044553;19992.100355484003;20001.59996800063;15522.53432397027;19410.70883936742;19716.408507744756;20219.494512637193;20228.786272823603;5608.663480191181;5817.41825817417;5900.380460051697;5907.113932910055;5933.762649494015;5513.145462453326;5699.088145896658;5743.626664266831;5753.223314852483;5862.824115276549;5083.237514372855;5710.343310519281;5767.538596912258;5786.942130578704;5808.854778630547;5420.376656684453;5635.042042852725;5703.714814259291;5766.971165144189;5770.9422905770825;4482.686211965164;4778.880527986794;4965.106280869442;4989.176785830334;4989.925151122736;19881.701774473393;24924.501509969698;25062.874685626455;25381.746182538307;25402.49195016108;2127.3830589129134;2211.8672879627275;2337.6960995070704;2368.2895131460664;2721.2380533450664;14489.927550362181;14840.628984275372;14883.47907823221;14914;15257.313420895975;1732.3936622182262;1753.3863147898135;1766.055160489145;1775.8046614872353;1807.0693592799719;82942;87090;102065.48967255116;106865.93134068715;110174.9999999992;8197.549134797524;10164.33931794431;10487.37075775456;10524.684259472227;10567.682969510926;12741.808872866914;12792.168509046882;12796.296203708886;12858.614241572768;12894.613161605166;8450.239478446847;8464.746057618282;8475.915240847513;8491.320694344438;8554.18735220153;8614.87077693835;8692.608832602547;8708.956455217683;8775.166359195866;8784.78038049041;6064.848378790477;6175.073738939195;6194.256689197235;6216;6261.311255761862;1826.5981484073482;1827.3512902919272;1846.0861873372498;1861.9348322808637;1864.7016477363557;852.9616167272487;947.2564037230741;954.8684808501947;1071.3357718214756;1079.6275285026654;19868;20040.89979550093;20435.897820511098;20647.27734529284;20778.376648700563;737.71229220604;918.8162367526521;926.5506229478698;932.5523748600709;949.539473355422;9263.397879137834;10370.896291037145;10451.372917624967;10646.680599582025;10677.359358438363;638811;641014;646829;665823;668262;114723;115028.27457588143;120926;122618.38690806668;126046.7395326035;1064.2603390643428;1072.4798472740715;1074.7528068544123;1091.0126335666234;1093.1309608860975;15624.984376015522;16601.418950337164;17973.191206396004;18031.819681803016;18201.27194912189;51817.7409112952;52743.20885186648;52933;54040.45959540354;54879.17681234705;72802.63598682184;73231;74786;75742;78291;7894.184337602269;8109.553974531457;8134.918650813416;8136.22705842944;8138.87791683137;12126.878731212575;12449.25304481734;12579.119461637598;12745.10784245131;12819.42312595954;10840.566377344818;10993.890061099606;11139.220254582102;11199.832002519806;11220.270682405617;10508.894911051097;10704.464776761286;10706.571737130427;10798.298110622783;10982.450877456255;10830.620928267474;11056.115510758958;11218.382988935688;11279.774404512027;11466;7616.314531692175;7811.765647030598;7860.764177074697;7933.880991785012;8254.380921430797;8075.394345423999;9410.870695516582;9727.124558789743;10168.440735759605;10493.632722854663 12:47:55 INFO - PROCESS | 1674 | |3;mootools.html;1584.1999790105995;1614.4510866305454;1858.9907050464747;1928.228708516593;1945.698416745405;7985.640646170922;8634.697785577506;8741.082186370435;8965.28277737781;8981.191692747643;8706.564671766419;8718.476891386521;8753.3872628916;8758.124187581254;8813.867791983126;2055.3114706573315;2465.3097132802845;2487.3781554611346;2498.8875500602426;2503.5869081601513;2444.9511009779794;2454.2759885833634;2476.319012271622;2480.9751902481016;2486.577281862079;2481;2482.453860150764;2503.9374015649664;2505.6116301973225;2509.2472258322523;2457.58221102413;2460.8277420580566;2475.591527397977;2487.701475822904;2490.887910044052;2452.1172377943926;2468.3705655058025;2481.7642323979194;2492.526419980198;2501.3371456564023;8937.419067760575;8942.821143577092;8956;8962.14859588338;9004.459732416011;5468;5514.0901751211;5531.474509921592;5592.468715472024;5623.240862483553;3573.4639804029343;3618.294432585647;3635.2366003139373;3701.204241088179;3717.516722826015;1013.4628646817125;1051.5686479334229;1053.2627160987263;1057.148995058977;1065.536491626145;12013.399330033464;12014.879851201464;12065.215760975509;12072.879271207352;12149.967252783525;4857.53853383928;4871.050145221719;4940.456549779521;4957.975210123926;4972.428170760337;10126.291159618757;10129.898701013042;10208.030237127461;10213.234007449471;10247.077763001365;5460.34475862899;5532.170174473861;5557.194206839986;5579.721013949286;5593.300837395325;4112.465379500646;4510.233260345749;5023.246513023076;5024.84925452237;5080.110980578458;3849.7882616455804;3929.76421414716;3940.4680368150507;3953.743006704555;3988.80055997199;1291.1671971578467;1316.1839659411226;1323;1323.9474617678968;1333.5132676573176;1140.8288756686563;1283.9920662280251;1360.395607014481;1381.1022835157228;1387.1607677355257;8114.269715725613;8235.670573177005;8264.380171487042;8281.83436331282;8285.627146778288;499.35084390292474;516.7726200471781;520.2482412913304;521.4993606138074;522.3027258609799;6171.352008039091;6186.257649082139;6238.594491358138;6306.590071645328;6319.304876463585;10545.736356591147;10631.255812093234;10827.83758243627;10848.837267440995;10914.890851091546;10518.316309439862;10612.734681632866;10653.147748180127;10732.248742587944;10748.570057197781;8315.792105197419;8372.665093396317;8421.199986001442;8426.873596896052;8451.408401411965;7767.495112817649;7902.881456778268;7905.56519391439;7966.243206895336;8079.959600202196;9478.478683672189;9480.146786789222;9610.663626773308;9641.27690423235;9641.614335426784;9814.116729494379;9899.307048506535;9994.250431217542;10077.294589378673;10155.54300056514;6784.2876497967;7221.097362829646;7433.293837085685;7577.583232922242;7639.465237433326;8151.877721834058;8340.332773378237;8384.496930184208;8418.873716894374;8431.241188293083;7347.19180890091;7492.70029198826;7577.696892124253;7588.582627955516;7616.352610027988;7322.3775979042375;7325.340719335285;7338.889916651361;7360.263973602597;7491.026166598307;7796.025496812898;7801.921980780119;7802.726904558313;7835.451518393657;7844.333231675371;7001.50989430735;7010.263922288086;7028.016077749221;7043.295670432915;7106.467014973794;7114.50198486101;7149.428045756223;7152.177499587614;7194.964025179841;7238.493305468567 12:47:55 INFO - PROCESS | 1674 | |4;prototype.html;320.7097576693092;324.7840186276126;328.9111939776259;330.52239513902407;334.6419331315492;6802.421794147497;6885.931140688592;6951.131108611424;6957.443404527645;6992.091028166331;6790.388865002149;6798.694058767355;6847.041414202015;6857.828554286145;6870.209925858528;4824.734639594821;4878.585320247783;4981.0037992401485;4982.651214414992;5062.063518249127;4968.776405061781;4972.627052971042;4979.128652485801;4982.950170498285;4987.251912213179;4007.779572123532;4942.665480320311;4956.553910148086;4987.800487980477;4992.176290912013;4114.670826333886;4980.850574482772;4982.202847544394;4991.201407774775;5004.699718016913;4186.099988502456;4276.593723596254;4279.379489973936;4287.078278170177;4292.420523229355;6307.148534947769;6495.642739649317;6554.1151944487365;6565.54041217115;6598.043283723881;4691.62467002639;4851.471786387312;5868;5955.285365756137;5984.281886173643;5956.106584012433;7049.259827718119;7196.208417074117;7221.602811845346;7254.492185547014;4731.597814185799;4761.47623761386;4771.212749896263;4779.737114458703;4784.138855006132;7632.351250143689;7666.961665191694;7689.923100768977;7691.692332306701;7719.112302085276;4644.698094623838;4835.6131509479155;4853.975730121327;4864.391951006124;4899.853004409873;4949.604031677457;4955.2567114933045;4966.577840883565;4984.5513903748115;4989.550940415307;5869.06095024794;5901.291844978544;5903.675297858659;5920.467157955804;5922.911156332659;7234.385077268385;7261.782146535613;7262.455315851333;7273.89089163663;7274.945132955691;1712.220939472537;1725.7325114607004;1728.9481315560554;1729.152715169558;1734.913254337278;1060.2260349944584;1109.6892869996414;1115.6151127860876;1118.373710721982;1126.898579127866;6715.529912906148;6762.289959554176;6777.559458635173;6788.253292137861;6798.082258894986;6028.728707208186;7455.105387353444;7546.169921308651;7548.66031028605;7563.7352692655495;6487.837804054936;6542.901856472156;6722.260551339349;6777.559458635272;6799.4900382471515;3419.4186988212064;3961.9405708914387;3993.860214892523;4027.2549578328103;4032.6169013943627;7961.761147165595;7966.84066318682;7980.241877021674;7993.440459167802;8021.919780802234;6344;7533.886991695129;7804.336631386395;7825.100113486908;7879.2120787921895;7933.484323518953;7953.32396746283;7954.960225198837;7969.8406031880195;7973.282404583615;7557.319841214317;7580.54516728998;7607.239276072349;7611.733589324347;7613.581253030915;7432.814179645552;7488.101427828696;7598.544087354777;7613.885791713018;7621.009268795021;7645.732399365996;7917.129115797373;7941.761747147595;7959.363250940027;7987.440879138405;4293.506246781535;4852.975735121302;4881.585065269492;4905.068037072945;4930.728809915489;6491.318411566717;7177.641117943977;7533.3973282138395;7566.659500322608;7597.772066838003;6303.212098487689;6810.250872403933;7226.349628533457;7322.5972571506945;7369.705211791683;7045.929540704732;7290.526115802456;7312.488125831141;7326.157491888501;7332.0834895638045;6388.425041746265;6404.615723056631;7126.821829454305;7140.036095127299;7167.677454514664;7301.707931682886;7302.379297759538;7329.010583571363;7338.412926965723;7344.265573442613;7140.821479463055;7162.570245785269;7162.856742865009;7170.42636589082;7184.9640751795905 12:47:55 INFO - PROCESS | 1674 | |5;yui.html;685.054624618027;685.4893104637047;709.2659097833744;749.2320371619093;762.9885551716721;15010.474633387834;15044;15106.320215590298;15160.848391516081;15185.39258429663;13820.585382438543;13918.373673184706;13919.652008699788;13960.860391396083;14296.785548216785;876.8465518534263;913.853783394657;913.8949020862586;913.9771505712378;916.8120535290283;895.5074708910106;901.6123067081153;901.779064129286;905.42053086025;906.9138431848996;935.4948327902924;955.4649396338039;956.7464621875208;957.3681370295607;957.4064080270207;933.3186773655236;949.8432758594823;952.5475399185366;953.0897992417225;954.9236061115095;678.7115475922714;682.5120039172016;683.0198664915862;692.0449779304578;693.2409012131708;14325.713485730332;14660.70678586433;14725.190114543695;14766.96631235814;14768.113913165136;12385.566505172366;12421.503139874394;12456.439460224312;12529.812052819216;12602.68493287666;9869.457179855106;9936.25478089139;9962.953889841534;9965.551550180187;10277.126444252248;3434.793912365266;3484.1463841358777;3491;3518.7185025197923;3588.4079126944025;74527;81817.77273340905;82174.17825821725;82958;84168.57915710383;8176.959115204386;8695.739127826175;9268.582913768896;9410.811783764424;9447.055294470498;20176.69734953977;20454.284100056426;20477.692834607493;20477.692834607493;20493.487662808548;7366.189719130892;7488.138864030598;7512.924870751332;7566.924330756732;7585.810354741176;3998.200359928026;4042.1915616876154;4043.8584649537715;4059.6346328830546;4060.634542891154;3619.6199399063244;3652.726045546595;3665.1203711109674;3668.4680721295263;3679.8344074516713;654.8002859127917;654.9574277672032;674.6356967237734;677.2786981864299;680.6120511308507;575.9654420734769;578.2020811280406;601.7141857617684;608.7047781825811;624.5503237668871;8181.590920453954;8232.917670823215;8307.626156822958;8388.328933685412;8500.234978851933;543.8069485332729;545.6235197713565;610.7892776991931;610.9358517355614;613.441767991126;3616.5479315085613;3828.712846536521;3852.57621661617;3931.6068393161027;3956;90030;97116.54325185128;97141.51429242949;98843;99174.00825991791;70849.6457517709;73185;81085.59457202676;82016;82705.58647206725;68347;69043;69537;73167.63416182886;73631.63184184044;7581.128170260491;7734.497257678233;8212.589370531568;8316.459430137264;8332.208440198172;48872;50245.74877125591;50301;51477.22784158315;51759.48240517547;59264;62936.055959159734;71524;71557.64221178861;72933;8698.739037828875;10695.358278503314;10795.784084318428;11114.110871130451;11624.593139240085;12049;12279.938600306941;12384.256944583354;12405.131640785059;12473.812892806434;11143.442827858413;11339.773204536028;11589.362585057903;11640.01059909917;11699.12256580777;10742.409167495864;10944.507497162487;11380.772384552429;11476.885231147582;11789;10912.727181820517;11141.888581114084;11194.608188713355;11303.717407064889;11591.710207244887;9444.858327125236;9676.419414835133;9676.548517722398;9782.364146330467;9932.652357167464;8662.35032372562;8784.692535761218;9354.29842761782;9650.95174524123;9652.662156824477 12:47:55 INFO - PROCESS | 1674 | __end_tp_report 12:47:55 INFO - PROCESS | 1674 | __start_cc_report 12:47:55 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,370 12:47:55 INFO - PROCESS | 1674 | __end_cc_report 12:47:55 INFO - PROCESS | 1674 | __startTimestamp1458848875621__endTimestamp 12:47:55 INFO - PROCESS | 1674 | 12:47:55 INFO - PROCESS | 1674 | ------- Summary: start ------- 12:47:55 INFO - PROCESS | 1674 | Number of tests: 6 12:47:55 INFO - PROCESS | 1674 | 12:47:55 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5814.16 Median:6139.57 stddev:799.45 (13.0%) stddev-sans-first:779.49 12:47:55 INFO - PROCESS | 1674 | Values: 3418.0 3521.9 3562.4 3578.9 3608.7 5789.7 5791.3 5805.0 5824.5 5853.9 5683.7 5733.2 5789.0 5817.2 5911.0 5207.1 5297.1 5305.9 5344.2 5359.1 404.2 5255.3 5310.4 5340.7 5401.0 5259.9 5280.8 5295.8 5317.6 5324.3 5211.2 5333.7 5344.2 5371.7 5392.7 5238.1 5243.1 5307.2 5316.2 5355.7 5628.4 5705.2 5709.5 5718.0 5762.3 6166.7 6259.3 6283.9 6345.9 6348.6 6300.7 6328.1 6344.9 6349.5 6354.8 5991.9 5992.5 5997.8 6013.6 6026.7 6271.6 6384.2 6456.9 6457.0 6457.7 6255.2 6261.0 6282.2 6294.2 6301.3 6330.6 6333.9 6337.4 6340.9 6361.5 6181.1 6224.5 6294.8 6321.1 6358.5 5842.6 6265.9 6336.9 6343.7 6354.3 4400.6 4993.9 5039.7 5050.0 5062.9 3684.5 3895.5 4396.1 4442.4 4505.7 5732.6 5781.6 5947.9 5948.0 6020.4 5290.3 6329.7 6330.0 6342.3 6379.0 5846.6 5951.6 5991.9 6050.1 6086.3 4598.0 5404.1 5451.4 5469.2 5469.5 6351.6 6488.6 6496.7 6510.4 6527.6 6198.1 6307.8 6330.3 6369.4 6371.5 6463.7 6476.4 6497.7 6504.3 6513.4 6155.5 6233.6 6295.4 6345.6 6356.8 6289.7 6296.1 6327.8 6343.9 6344.4 6196.4 6219.2 6314.1 6332.1 6337.5 6139.6 6196.2 6297.4 6341.2 6343.1 5905.3 6108.8 6133.0 6153.3 6161.5 6194.9 6278.8 6281.3 6291.3 6292.4 6036.1 6095.7 6198.6 6207.1 6211.7 12:47:55 INFO - PROCESS | 1674 | 12:47:55 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:69485.23 Median:38471.52 stddev:153148.84 (398.1%) stddev-sans-first:153490.81 12:47:55 INFO - PROCESS | 1674 | Values: 471.4 509.8 548.1 604.3 621.4 39414.8 40123.8 40178.0 40191.2 40322.6 41518.6 41987.4 42218.0 42218.2 42301.6 9410.0 9465.8 9557.1 9647.7 9679.4 9547.1 9561.3 9657.5 9662.9 9703.7 9489.0 9607.8 9624.7 9724.2 9731.7 9565.1 9608.0 9612.8 9692.9 9696.0 8269.0 9549.4 9645.2 9703.4 9773.1 38043.4 38277.0 38666.0 38900.6 39068.0 2624.8 3012.8 3197.8 3386.1 3430.6 26920.9 26980.0 27195.7 27751.6 27893.9 2666.2 2668.3 2694.3 2714.7 2924.3 368906.0 398636.0 413202.0 416497.9 416966.0 65925.0 66782.7 66852.0 67019.3 67050.0 68768.0 72793.6 74049.9 76316.6 76384.0 16470.4 16968.2 16983.6 17148.1 17174.4 12793.4 12851.9 12983.0 13050.1 13056.6 21349.8 21634.0 21949.7 22017.3 22043.0 7747.3 9115.3 9364.2 9380.9 9469.4 947.2 947.6 1003.6 1019.9 1021.9 27404.9 29469.3 29877.1 29949.4 30089.7 1084.8 1099.3 1105.6 1131.3 1147.1 14896.9 14968.9 14996.9 15206.7 15286.2 738854.0 741282.0 750494.0 751971.0 757648.0 59586.5 60787.7 61014.5 61176.7 61222.0 1501.9 1510.5 1511.4 1514.9 1551.1 29982.9 30638.4 30685.5 31538.5 31884.9 51724.7 51910.5 52007.0 52361.7 52644.2 502925.0 507089.9 507162.0 507976.0 508188.0 33222.8 33596.8 33953.8 34143.8 34319.7 44958.6 45712.5 45959.0 46056.8 46600.0 36542.9 36828.0 37123.4 37195.0 37679.0 36645.5 37244.9 37324.0 37534.8 38081.4 36572.5 36649.3 36991.6 37185.3 37218.3 28992.7 33758.5 33977.0 34677.3 34753.3 23130.4 24398.0 24591.0 24734.8 24858.6 12:47:55 INFO - PROCESS | 1674 | 12:47:55 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:35501.00 Median:24993.69 stddev:107844.02 (431.5%) stddev-sans-first:108114.17 12:47:55 INFO - PROCESS | 1674 | Values: 303.4 353.7 357.5 362.6 368.0 19183.7 19673.4 19973.1 19992.1 20001.6 15522.5 19410.7 19716.4 20219.5 20228.8 5608.7 5817.4 5900.4 5907.1 5933.8 5513.1 5699.1 5743.6 5753.2 5862.8 5083.2 5710.3 5767.5 5786.9 5808.9 5420.4 5635.0 5703.7 5767.0 5770.9 4482.7 4778.9 4965.1 4989.2 4989.9 19881.7 24924.5 25062.9 25381.7 25402.5 2127.4 2211.9 2337.7 2368.3 2721.2 14489.9 14840.6 14883.5 14914.0 15257.3 1732.4 1753.4 1766.1 1775.8 1807.1 82942.0 87090.0 102065.5 106865.9 110175.0 8197.5 10164.3 10487.4 10524.7 10567.7 12741.8 12792.2 12796.3 12858.6 12894.6 8450.2 8464.7 8475.9 8491.3 8554.2 8614.9 8692.6 8709.0 8775.2 8784.8 6064.8 6175.1 6194.3 6216.0 6261.3 1826.6 1827.4 1846.1 1861.9 1864.7 853.0 947.3 954.9 1071.3 1079.6 19868.0 20040.9 20435.9 20647.3 20778.4 737.7 918.8 926.6 932.6 949.5 9263.4 10370.9 10451.4 10646.7 10677.4 638811.0 641014.0 646829.0 665823.0 668262.0 114723.0 115028.3 120926.0 122618.4 126046.7 1064.3 1072.5 1074.8 1091.0 1093.1 15625.0 16601.4 17973.2 18031.8 18201.3 51817.7 52743.2 52933.0 54040.5 54879.2 72802.6 73231.0 74786.0 75742.0 78291.0 7894.2 8109.6 8134.9 8136.2 8138.9 12126.9 12449.3 12579.1 12745.1 12819.4 10840.6 10993.9 11139.2 11199.8 11220.3 10508.9 10704.5 10706.6 10798.3 10982.5 10830.6 11056.1 11218.4 11279.8 11466.0 7616.3 7811.8 7860.8 7933.9 8254.4 8075.4 9410.9 9727.1 10168.4 10493.6 12:47:55 INFO - PROCESS | 1674 | 12:47:55 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:6100.63 Median:521.90 stddev:3233.13 (619.5%) stddev-sans-first:3224.38 12:47:55 INFO - PROCESS | 1674 | Values: 1584.2 1614.5 1859.0 1928.2 1945.7 7985.6 8634.7 8741.1 8965.3 8981.2 8706.6 8718.5 8753.4 8758.1 8813.9 2055.3 2465.3 2487.4 2498.9 2503.6 2445.0 2454.3 2476.3 2481.0 2486.6 2481.0 2482.5 2503.9 2505.6 2509.2 2457.6 2460.8 2475.6 2487.7 2490.9 2452.1 2468.4 2481.8 2492.5 2501.3 8937.4 8942.8 8956.0 8962.1 9004.5 5468.0 5514.1 5531.5 5592.5 5623.2 3573.5 3618.3 3635.2 3701.2 3717.5 1013.5 1051.6 1053.3 1057.1 1065.5 12013.4 12014.9 12065.2 12072.9 12150.0 4857.5 4871.1 4940.5 4958.0 4972.4 10126.3 10129.9 10208.0 10213.2 10247.1 5460.3 5532.2 5557.2 5579.7 5593.3 4112.5 4510.2 5023.2 5024.8 5080.1 3849.8 3929.8 3940.5 3953.7 3988.8 1291.2 1316.2 1323.0 1323.9 1333.5 1140.8 1284.0 1360.4 1381.1 1387.2 8114.3 8235.7 8264.4 8281.8 8285.6 499.4 516.8 520.2 521.5 522.3 6171.4 6186.3 6238.6 6306.6 6319.3 10545.7 10631.3 10827.8 10848.8 10914.9 10518.3 10612.7 10653.1 10732.2 10748.6 8315.8 8372.7 8421.2 8426.9 8451.4 7767.5 7902.9 7905.6 7966.2 8080.0 9478.5 9480.1 9610.7 9641.3 9641.6 9814.1 9899.3 9994.3 10077.3 10155.5 6784.3 7221.1 7433.3 7577.6 7639.5 8151.9 8340.3 8384.5 8418.9 8431.2 7347.2 7492.7 7577.7 7588.6 7616.4 7322.4 7325.3 7338.9 7360.3 7491.0 7796.0 7801.9 7802.7 7835.5 7844.3 7001.5 7010.3 7028.0 7043.3 7106.5 7114.5 7149.4 7152.2 7195.0 7238.5 12:47:55 INFO - PROCESS | 1674 | 12:47:55 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5934.77 Median:6742.28 stddev:1912.17 (28.4%) stddev-sans-first:1870.53 12:47:55 INFO - PROCESS | 1674 | Values: 320.7 324.8 328.9 330.5 334.6 6802.4 6885.9 6951.1 6957.4 6992.1 6790.4 6798.7 6847.0 6857.8 6870.2 4824.7 4878.6 4981.0 4982.7 5062.1 4968.8 4972.6 4979.1 4983.0 4987.3 4007.8 4942.7 4956.6 4987.8 4992.2 4114.7 4980.9 4982.2 4991.2 5004.7 4186.1 4276.6 4279.4 4287.1 4292.4 6307.1 6495.6 6554.1 6565.5 6598.0 4691.6 4851.5 5868.0 5955.3 5984.3 5956.1 7049.3 7196.2 7221.6 7254.5 4731.6 4761.5 4771.2 4779.7 4784.1 7632.4 7667.0 7689.9 7691.7 7719.1 4644.7 4835.6 4854.0 4864.4 4899.9 4949.6 4955.3 4966.6 4984.6 4989.6 5869.1 5901.3 5903.7 5920.5 5922.9 7234.4 7261.8 7262.5 7273.9 7274.9 1712.2 1725.7 1728.9 1729.2 1734.9 1060.2 1109.7 1115.6 1118.4 1126.9 6715.5 6762.3 6777.6 6788.3 6798.1 6028.7 7455.1 7546.2 7548.7 7563.7 6487.8 6542.9 6722.3 6777.6 6799.5 3419.4 3961.9 3993.9 4027.3 4032.6 7961.8 7966.8 7980.2 7993.4 8021.9 6344.0 7533.9 7804.3 7825.1 7879.2 7933.5 7953.3 7955.0 7969.8 7973.3 7557.3 7580.5 7607.2 7611.7 7613.6 7432.8 7488.1 7598.5 7613.9 7621.0 7645.7 7917.1 7941.8 7959.4 7987.4 4293.5 4853.0 4881.6 4905.1 4930.7 6491.3 7177.6 7533.4 7566.7 7597.8 6303.2 6810.3 7226.3 7322.6 7369.7 7045.9 7290.5 7312.5 7326.2 7332.1 6388.4 6404.6 7126.8 7140.0 7167.7 7301.7 7302.4 7329.0 7338.4 7344.3 7140.8 7162.6 7162.9 7170.4 7185.0 12:47:55 INFO - PROCESS | 1674 | 12:47:55 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18382.80 Median:678.00 stddev:26155.55 (3857.8%) stddev-sans-first:26195.17 12:47:55 INFO - PROCESS | 1674 | Values: 685.1 685.5 709.3 749.2 763.0 15010.5 15044.0 15106.3 15160.8 15185.4 13820.6 13918.4 13919.7 13960.9 14296.8 876.8 913.9 913.9 914.0 916.8 895.5 901.6 901.8 905.4 906.9 935.5 955.5 956.7 957.4 957.4 933.3 949.8 952.5 953.1 954.9 678.7 682.5 683.0 692.0 693.2 14325.7 14660.7 14725.2 14767.0 14768.1 12385.6 12421.5 12456.4 12529.8 12602.7 9869.5 9936.3 9963.0 9965.6 10277.1 3434.8 3484.1 3491.0 3518.7 3588.4 74527.0 81817.8 82174.2 82958.0 84168.6 8177.0 8695.7 9268.6 9410.8 9447.1 20176.7 20454.3 20477.7 20477.7 20493.5 7366.2 7488.1 7512.9 7566.9 7585.8 3998.2 4042.2 4043.9 4059.6 4060.6 3619.6 3652.7 3665.1 3668.5 3679.8 654.8 655.0 674.6 677.3 680.6 576.0 578.2 601.7 608.7 624.6 8181.6 8232.9 8307.6 8388.3 8500.2 543.8 545.6 610.8 610.9 613.4 3616.5 3828.7 3852.6 3931.6 3956.0 90030.0 97116.5 97141.5 98843.0 99174.0 70849.6 73185.0 81085.6 82016.0 82705.6 68347.0 69043.0 69537.0 73167.6 73631.6 7581.1 7734.5 8212.6 8316.5 8332.2 48872.0 50245.7 50301.0 51477.2 51759.5 59264.0 62936.1 71524.0 71557.6 72933.0 8698.7 10695.4 10795.8 11114.1 11624.6 12049.0 12279.9 12384.3 12405.1 12473.8 11143.4 11339.8 11589.4 11640.0 11699.1 10742.4 10944.5 11380.8 11476.9 11789.0 10912.7 11141.9 11194.6 11303.7 11591.7 9444.9 9676.4 9676.5 9782.4 9932.7 8662.4 8784.7 9354.3 9651.0 9652.7 12:47:55 INFO - PROCESS | 1674 | -------- Summary: end -------- 12:47:55 INFO - PROCESS | 1674 | 12:47:56 INFO - TEST-INFO | 1674: exit 0 12:47:56 INFO - TEST-OK | dromaeo_css | took 1110656ms 12:47:56 INFO - TEST-START | kraken 12:47:56 INFO - operating with platform_type : mac_ 12:47:56 INFO - Initialising browser for kraken test... 12:47:56 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmp4n1DzX/profile http://localhost:49271/getInfo.html) 12:47:58 INFO - PROCESS | 1683 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 12:47:59 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 12:47:59 INFO - PROCESS | 1683 | colorDepth:24 12:47:59 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 12:47:59 INFO - PROCESS | 1683 | __metrics 12:47:59 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 12:47:59 INFO - TEST-INFO | 1683: exit 0 12:47:59 INFO - Browser initialized. 12:47:59 INFO - Running cycle 1/1 for kraken test... 12:47:59 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmp4n1DzX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:48:11 INFO - PROCESS | 1686 | RSS: Main: 254722048 12:48:11 INFO - PROCESS | 1686 | 12:48:14 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 12:48:15 INFO - PROCESS | 1686 | RSS: Main: 267276288 12:48:15 INFO - PROCESS | 1686 | 12:48:17 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 12:48:18 INFO - PROCESS | 1686 | RSS: Main: 275681280 12:48:18 INFO - PROCESS | 1686 | 12:48:21 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 12:48:22 INFO - PROCESS | 1686 | RSS: Main: 278982656 12:48:22 INFO - PROCESS | 1686 | 12:48:24 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 12:48:25 INFO - PROCESS | 1686 | RSS: Main: 280039424 12:48:25 INFO - PROCESS | 1686 | 12:48:27 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:48:27 INFO - PROCESS | 1686 | RSS: Main: 280420352 12:48:27 INFO - PROCESS | 1686 | 12:48:30 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 12:48:31 INFO - PROCESS | 1686 | RSS: Main: 282005504 12:48:31 INFO - PROCESS | 1686 | 12:48:34 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 12:48:35 INFO - PROCESS | 1686 | RSS: Main: 281944064 12:48:35 INFO - PROCESS | 1686 | 12:48:38 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 12:48:38 INFO - PROCESS | 1686 | RSS: Main: 282054656 12:48:38 INFO - PROCESS | 1686 | 12:48:40 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:48:41 INFO - PROCESS | 1686 | RSS: Main: 282062848 12:48:41 INFO - PROCESS | 1686 | 12:48:42 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:48:43 INFO - PROCESS | 1686 | RSS: Main: 282079232 12:48:43 INFO - PROCESS | 1686 | 12:48:45 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:48:46 INFO - PROCESS | 1686 | RSS: Main: 281972736 12:48:46 INFO - PROCESS | 1686 | 12:48:49 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:48:49 INFO - PROCESS | 1686 | RSS: Main: 282103808 12:48:49 INFO - PROCESS | 1686 | 12:48:52 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:48:52 INFO - PROCESS | 1686 | RSS: Main: 282062848 12:48:52 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 12:48:54 INFO - PROCESS | 1686 | RSS: Main: 283926528 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | __start_tp_report 12:48:54 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 12:48:54 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 12:48:54 INFO - PROCESS | 1686 | |i|pagename|runs| 12:48:54 INFO - PROCESS | 1686 | |0;ai-astar;116;111;116;115;114;129;114;115;116;116 12:48:54 INFO - PROCESS | 1686 | |1;audio-beat-detection;153;138;166;191;152;138;123;192;145;153 12:48:54 INFO - PROCESS | 1686 | |2;audio-dft;193;198;227;198;265;205;285;286;212;202 12:48:54 INFO - PROCESS | 1686 | |3;audio-fft;72;66;74;119;66;57;51;50;117;53 12:48:54 INFO - PROCESS | 1686 | |4;audio-oscillator;82;116;157;116;92;81;116;79;81;112 12:48:54 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;94;90;86;133;137;110;93;90;91;89 12:48:54 INFO - PROCESS | 1686 | |6;imaging-darkroom;142;97;96;135;96;120;153;97;97;97 12:48:54 INFO - PROCESS | 1686 | |7;imaging-desaturate;151;145;90;124;145;147;101;113;145;92 12:48:54 INFO - PROCESS | 1686 | |8;json-parse-financial;50;56;68;85;87;60;58;65;58;55 12:48:54 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;64;65;71;69;79;75;72;69;67;70 12:48:54 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;85;85;86;87;85;97;117;110;106;88 12:48:54 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;139;125;130;159;146;149;112;151;136;143 12:48:54 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;135;185;182;148;142;138;141;144;142;131 12:48:54 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;69;68;74;81;105;96;96;77;70;67 12:48:54 INFO - PROCESS | 1686 | __end_tp_report 12:48:54 INFO - PROCESS | 1686 | __start_cc_report 12:48:54 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,961 12:48:54 INFO - PROCESS | 1686 | __end_cc_report 12:48:54 INFO - PROCESS | 1686 | __startTimestamp1458848934939__endTimestamp 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | ------- Summary: start ------- 12:48:54 INFO - PROCESS | 1686 | Number of tests: 14 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:116.20 Median:116.00 stddev:4.76 (4.1%) stddev-sans-first:5.04 12:48:54 INFO - PROCESS | 1686 | Values: 116.0 111.0 116.0 115.0 114.0 129.0 114.0 115.0 116.0 116.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:153.00 stddev:22.37 (14.6%) stddev-sans-first:23.72 12:48:54 INFO - PROCESS | 1686 | Values: 153.0 138.0 166.0 191.0 152.0 138.0 123.0 192.0 145.0 153.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:227.10 Median:219.50 stddev:37.21 (17.0%) stddev-sans-first:37.36 12:48:54 INFO - PROCESS | 1686 | Values: 193.0 198.0 227.0 198.0 265.0 205.0 285.0 286.0 212.0 202.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:72.50 Median:61.50 stddev:25.43 (41.3%) stddev-sans-first:26.97 12:48:54 INFO - PROCESS | 1686 | Values: 72.0 66.0 74.0 119.0 66.0 57.0 51.0 50.0 117.0 53.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:80.00 stddev:24.97 (31.2%) stddev-sans-first:25.27 12:48:54 INFO - PROCESS | 1686 | Values: 82.0 116.0 157.0 116.0 92.0 81.0 116.0 79.0 81.0 112.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:101.30 Median:90.00 stddev:18.93 (21.0%) stddev-sans-first:19.89 12:48:54 INFO - PROCESS | 1686 | Values: 94.0 90.0 86.0 133.0 137.0 110.0 93.0 90.0 91.0 89.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:113.00 Median:96.50 stddev:22.55 (23.4%) stddev-sans-first:21.34 12:48:54 INFO - PROCESS | 1686 | Values: 142.0 97.0 96.0 135.0 96.0 120.0 153.0 97.0 97.0 97.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:125.30 Median:146.00 stddev:24.48 (16.8%) stddev-sans-first:24.14 12:48:54 INFO - PROCESS | 1686 | Values: 151.0 145.0 90.0 124.0 145.0 147.0 101.0 113.0 145.0 92.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:62.50 stddev:12.54 (20.1%) stddev-sans-first:12.20 12:48:54 INFO - PROCESS | 1686 | Values: 50.0 56.0 68.0 85.0 87.0 60.0 58.0 65.0 58.0 55.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:4.51 (6.4%) stddev-sans-first:4.21 12:48:54 INFO - PROCESS | 1686 | Values: 64.0 65.0 71.0 69.0 79.0 75.0 72.0 69.0 67.0 70.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:94.60 Median:85.50 stddev:12.14 (14.2%) stddev-sans-first:12.37 12:48:54 INFO - PROCESS | 1686 | Values: 85.0 85.0 86.0 87.0 85.0 97.0 117.0 110.0 106.0 88.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:144.50 stddev:13.84 (9.6%) stddev-sans-first:14.68 12:48:54 INFO - PROCESS | 1686 | Values: 139.0 125.0 130.0 159.0 146.0 149.0 112.0 151.0 136.0 143.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:143.00 stddev:18.90 (13.2%) stddev-sans-first:19.37 12:48:54 INFO - PROCESS | 1686 | Values: 135.0 185.0 182.0 148.0 142.0 138.0 141.0 144.0 142.0 131.0 12:48:54 INFO - PROCESS | 1686 | 12:48:54 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.30 Median:75.50 stddev:13.81 (18.3%) stddev-sans-first:14.03 12:48:54 INFO - PROCESS | 1686 | Values: 69.0 68.0 74.0 81.0 105.0 96.0 96.0 77.0 70.0 67.0 12:48:54 INFO - PROCESS | 1686 | -------- Summary: end -------- 12:48:54 INFO - PROCESS | 1686 | 12:48:55 INFO - TEST-INFO | 1686: exit 0 12:48:55 INFO - TEST-OK | kraken | took 59513ms 12:48:55 INFO - SUITE-END | took 1170s 12:48:56 INFO - Completed test suite (00:19:30) 12:48:56 INFO - javascript benchmark 12:48:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3417.982910085449, 3521.8767343142986, 3562.358775420425, 3578.9463158052636, 3608.7113030957526, 5789.652620842752, 5791.333996590393, 5805.0, 5824.534037277018, 5853.853653658655, 5683.715814209294, 5733.226014488043, 5789.0, 5817.185594016831, 5911.0, 5207.088759467097, 5297.12597421425, 5305.8938821223555, 5344.171653393731, 5359.1425371940495, 404.2155443357117, 5255.277441216751, 5310.362756469229, 5340.652857564246, 5401.000814849246, 5259.947400525984, 5280.815171469018, 5295.761690723907, 5317.574594032468, 5324.254604355355, 5211.218317252443, 5333.653312534673, 5344.22508736235, 5371.650842695212, 5392.730363481849, 5238.109521381374, 5243.10867152585, 5307.150855863043, 5316.202569614588, 5355.732213389315, 5628.437156284339, 5705.229793977802, 5709.45760152789, 5718.027935251017, 5762.250907382014, 6166.722497487579, 6259.280182778994, 6283.937160628427, 6345.904811427832, 6348.555601107878, 6300.684965751694, 6328.050792381179, 6344.904826427607, 6349.4602958748565, 6354.809355719336, 5991.850203744898, 5992.49063829575, 5997.790077347316, 6013.639181649115, 6026.6986650667295, 6271.62370257786, 6384.170057892445, 6456.9354306456335, 6457.031445283245, 6457.677116144174, 6255.155554000152, 6261.0, 6282.246130464374, 6294.181756371642, 6301.275353334334, 6330.620162790247, 6333.873322533524, 6337.397947195009, 6340.936590634127, 6361.4592759615025, 6181.103739957681, 6224.502039836802, 6294.779682711083, 6321.1150438938585, 6358.523110766711, 5842.620229685142, 6265.937340626535, 6336.904946425807, 6343.682815859189, 6354.332795056545, 4400.581944715247, 4993.850184494471, 5039.722815245197, 5049.974750126299, 5062.924056139161, 3684.5210122684416, 3895.474110995036, 4396.098799746044, 4442.42248507692, 4505.7296562206375, 5732.566858285429, 5781.5952883298605, 5947.851303717355, 5948.0, 6020.4280593343565, 5290.338707661543, 6329.746810127635, 6329.968350158312, 6342.302346741854, 6378.968105159537, 5846.619969701956, 5951.553633477506, 5991.940080599138, 6050.062240352752, 6086.300075491286, 4597.95402045982, 5404.1353383459245, 5451.400345961941, 5469.15228139639, 5469.535089517356, 6351.618902865843, 6488.610683359014, 6496.740130394731, 6510.381513756186, 6527.640979746065, 6198.0702894566175, 6307.842303942254, 6330.272018717907, 6369.426751592379, 6371.458426033653, 6463.741450342121, 6476.352364763486, 6497.675116244074, 6504.317046710027, 6513.381228783258, 6155.538334624832, 6233.625982441068, 6295.401936815995, 6345.555811093179, 6356.841078973062, 6289.6540690260645, 6296.0555916612875, 6327.841803954938, 6343.90484142729, 6344.365563443619, 6196.380361963767, 6219.160413344322, 6314.052892066226, 6332.11350410952, 6337.493000560036, 6139.570230083851, 6196.1635179250225, 6297.370262973666, 6341.239051313872, 6343.080253363144, 5905.261842269716, 6108.847278818065, 6133.0, 6153.292371377349, 6161.537884658758, 6194.884920714315, 6278.843028924313, 6281.309056003927, 6291.307956124731, 6292.402221788922, 6036.094585812163, 6095.664738439428, 6198.597091189058, 6207.099970504342, 6211.65835879013], "unit": "score", "name": "dojo.html", "value": 5763.731716591453}, {"lowerIsBetter": false, "replicates": [471.36365906026845, 509.75786501411835, 548.0628125904703, 604.295995165632, 621.3599992008232, 39414.802925985365, 40123.799381003126, 40177.99555011126, 40191.19617607646, 40322.59677403229, 41518.58481415185, 41987.37018944718, 42218.0, 42218.15563688724, 42301.576984230145, 9409.95295023524, 9465.81068378632, 9557.13985741283, 9647.662331818388, 9679.419234845931, 9547.093026162504, 9561.33070685049, 9657.46883921384, 9662.855057174149, 9703.660371886985, 9488.952555237214, 9607.807843843118, 9624.663136790214, 9724.173445257162, 9731.659391921285, 9565.139137477661, 9608.039196080406, 9612.807743845118, 9692.90307096927, 9696.0, 8268.958655206745, 9549.379290346174, 9645.228381729445, 9703.369280996783, 9773.120419162238, 38043.429348559795, 38277.043073923094, 38666.0, 38900.61099388998, 39068.0, 2624.842509449439, 3012.834294113823, 3197.7921435106646, 3386.102682789063, 3430.6054803697643, 26920.865395672896, 26980.0, 27195.72804271952, 27751.583726244124, 27893.86053069742, 2666.186813022047, 2668.2662267876294, 2694.2994821346592, 2714.7149549297433, 2924.327404696932, 368906.0, 398636.00681996404, 413202.0, 416497.91751041356, 416966.0, 65925.0, 66782.66608666925, 66852.0, 67019.32980670228, 67050.0, 68767.96848047283, 72793.63603182056, 74049.88925166127, 76316.61841690868, 76384.0, 16470.42353517621, 16968.23642936071, 16983.575410614587, 17148.05685687299, 17174.39889603858, 12793.360331983364, 12851.935740321425, 12983.026273029373, 13050.086493945333, 13056.608301750963, 21349.78650213509, 21634.02646880894, 21949.67075493869, 22017.33947981531, 22043.00806463713, 7747.341475974606, 9115.316351273681, 9364.15722584957, 9380.90619093814, 9469.431834089977, 947.1522986926662, 947.6212111377929, 1003.5835128421623, 1019.9286049976579, 1021.8722659667542, 27404.862975684995, 29469.26326841846, 29877.10368688943, 29949.409446870242, 30089.69910300869, 1084.7721978384627, 1099.3184225780067, 1105.5798796457455, 1131.3494740524068, 1147.1167201254987, 14896.925515372353, 14968.850311496746, 14996.850031499545, 15206.695866082617, 15286.235688215545, 738854.0, 741282.0, 750494.0, 751971.0, 757648.0, 59586.51033724105, 60787.69606152029, 61014.4746381344, 61176.69411653002, 61222.0, 1501.8798496120285, 1510.5317351621034, 1511.3954418232795, 1514.9242537873283, 1551.1468692219235, 29982.850085749433, 30638.378160982178, 30685.53971690471, 31538.526922096647, 31884.88402905887, 51724.74137629288, 51910.48089519208, 52007.0, 52361.7381913088, 52644.21033684421, 502925.0, 507089.92910070426, 507162.0, 507976.0, 508188.0, 33222.83388583042, 33596.83201583976, 33953.83023084869, 34143.82928085344, 34319.65680343265, 44958.55041449674, 45712.54287457083, 45959.0, 46056.8485787858, 46600.0, 36542.903712888656, 36828.0, 37123.44314835333, 37195.0, 37679.0, 36645.45031824578, 37244.882653520435, 37324.0, 37534.8123259382, 38081.4287785689, 36572.451413229355, 36649.267014660094, 36991.630083698816, 37185.25629487341, 37218.25563488769, 28992.710072899845, 33758.498344929096, 33977.0, 34677.306453871286, 34753.304933900676, 23130.421739456648, 24398.0, 24591.0, 24734.763261836477, 24858.627120592842], "unit": "score", "name": "ext.html", "value": 20218.226437245394}, {"lowerIsBetter": false, "replicates": [303.3780749463599, 353.7028895727588, 357.5137812574898, 362.5812186924102, 368.03574634457726, 19183.712244316346, 19673.42612590993, 19973.10121044553, 19992.100355484003, 20001.59996800063, 15522.53432397027, 19410.70883936742, 19716.408507744756, 20219.494512637193, 20228.786272823603, 5608.663480191181, 5817.41825817417, 5900.380460051697, 5907.113932910055, 5933.762649494015, 5513.145462453326, 5699.088145896658, 5743.626664266831, 5753.223314852483, 5862.824115276549, 5083.237514372855, 5710.343310519281, 5767.538596912258, 5786.942130578704, 5808.854778630547, 5420.376656684453, 5635.042042852725, 5703.714814259291, 5766.971165144189, 5770.9422905770825, 4482.686211965164, 4778.880527986794, 4965.106280869442, 4989.176785830334, 4989.925151122736, 19881.701774473393, 24924.501509969698, 25062.874685626455, 25381.746182538307, 25402.49195016108, 2127.3830589129134, 2211.8672879627275, 2337.6960995070704, 2368.2895131460664, 2721.2380533450664, 14489.927550362181, 14840.628984275372, 14883.47907823221, 14914.0, 15257.313420895975, 1732.3936622182262, 1753.3863147898135, 1766.055160489145, 1775.8046614872353, 1807.0693592799719, 82942.0, 87090.0, 102065.48967255116, 106865.93134068715, 110174.9999999992, 8197.549134797524, 10164.33931794431, 10487.37075775456, 10524.684259472227, 10567.682969510926, 12741.808872866914, 12792.168509046882, 12796.296203708886, 12858.614241572768, 12894.613161605166, 8450.239478446847, 8464.746057618282, 8475.915240847513, 8491.320694344438, 8554.18735220153, 8614.87077693835, 8692.608832602547, 8708.956455217683, 8775.166359195866, 8784.78038049041, 6064.848378790477, 6175.073738939195, 6194.256689197235, 6216.0, 6261.311255761862, 1826.5981484073482, 1827.3512902919272, 1846.0861873372498, 1861.9348322808637, 1864.7016477363557, 852.9616167272487, 947.2564037230741, 954.8684808501947, 1071.3357718214756, 1079.6275285026654, 19868.0, 20040.89979550093, 20435.897820511098, 20647.27734529284, 20778.376648700563, 737.71229220604, 918.8162367526521, 926.5506229478698, 932.5523748600709, 949.539473355422, 9263.397879137834, 10370.896291037145, 10451.372917624967, 10646.680599582025, 10677.359358438363, 638811.0, 641014.0, 646829.0, 665823.0, 668262.0, 114723.0, 115028.27457588143, 120926.0, 122618.38690806668, 126046.7395326035, 1064.2603390643428, 1072.4798472740715, 1074.7528068544123, 1091.0126335666234, 1093.1309608860975, 15624.984376015522, 16601.418950337164, 17973.191206396004, 18031.819681803016, 18201.27194912189, 51817.7409112952, 52743.20885186648, 52933.0, 54040.45959540354, 54879.17681234705, 72802.63598682184, 73231.0, 74786.0, 75742.0, 78291.0, 7894.184337602269, 8109.553974531457, 8134.918650813416, 8136.22705842944, 8138.87791683137, 12126.878731212575, 12449.25304481734, 12579.119461637598, 12745.10784245131, 12819.42312595954, 10840.566377344818, 10993.890061099606, 11139.220254582102, 11199.832002519806, 11220.270682405617, 10508.894911051097, 10704.464776761286, 10706.571737130427, 10798.298110622783, 10982.450877456255, 10830.620928267474, 11056.115510758958, 11218.382988935688, 11279.774404512027, 11466.0, 7616.314531692175, 7811.765647030598, 7860.764177074697, 7933.880991785012, 8254.380921430797, 8075.394345423999, 9410.870695516582, 9727.124558789743, 10168.440735759605, 10493.632722854663], "unit": "score", "name": "jquery.html", "value": 9420.501058670887}, {"lowerIsBetter": false, "replicates": [1584.1999790105995, 1614.4510866305454, 1858.9907050464747, 1928.228708516593, 1945.698416745405, 7985.640646170922, 8634.697785577506, 8741.082186370435, 8965.28277737781, 8981.191692747643, 8706.564671766419, 8718.476891386521, 8753.3872628916, 8758.124187581254, 8813.867791983126, 2055.3114706573315, 2465.3097132802845, 2487.3781554611346, 2498.8875500602426, 2503.5869081601513, 2444.9511009779794, 2454.2759885833634, 2476.319012271622, 2480.9751902481016, 2486.577281862079, 2481.0, 2482.453860150764, 2503.9374015649664, 2505.6116301973225, 2509.2472258322523, 2457.58221102413, 2460.8277420580566, 2475.591527397977, 2487.701475822904, 2490.887910044052, 2452.1172377943926, 2468.3705655058025, 2481.7642323979194, 2492.526419980198, 2501.3371456564023, 8937.419067760575, 8942.821143577092, 8956.0, 8962.14859588338, 9004.459732416011, 5468.0, 5514.0901751211, 5531.474509921592, 5592.468715472024, 5623.240862483553, 3573.4639804029343, 3618.294432585647, 3635.2366003139373, 3701.204241088179, 3717.516722826015, 1013.4628646817125, 1051.5686479334229, 1053.2627160987263, 1057.148995058977, 1065.536491626145, 12013.399330033464, 12014.879851201464, 12065.215760975509, 12072.879271207352, 12149.967252783525, 4857.53853383928, 4871.050145221719, 4940.456549779521, 4957.975210123926, 4972.428170760337, 10126.291159618757, 10129.898701013042, 10208.030237127461, 10213.234007449471, 10247.077763001365, 5460.34475862899, 5532.170174473861, 5557.194206839986, 5579.721013949286, 5593.300837395325, 4112.465379500646, 4510.233260345749, 5023.246513023076, 5024.84925452237, 5080.110980578458, 3849.7882616455804, 3929.76421414716, 3940.4680368150507, 3953.743006704555, 3988.80055997199, 1291.1671971578467, 1316.1839659411226, 1323.0, 1323.9474617678968, 1333.5132676573176, 1140.8288756686563, 1283.9920662280251, 1360.395607014481, 1381.1022835157228, 1387.1607677355257, 8114.269715725613, 8235.670573177005, 8264.380171487042, 8281.83436331282, 8285.627146778288, 499.35084390292474, 516.7726200471781, 520.2482412913304, 521.4993606138074, 522.3027258609799, 6171.352008039091, 6186.257649082139, 6238.594491358138, 6306.590071645328, 6319.304876463585, 10545.736356591147, 10631.255812093234, 10827.83758243627, 10848.837267440995, 10914.890851091546, 10518.316309439862, 10612.734681632866, 10653.147748180127, 10732.248742587944, 10748.570057197781, 8315.792105197419, 8372.665093396317, 8421.199986001442, 8426.873596896052, 8451.408401411965, 7767.495112817649, 7902.881456778268, 7905.56519391439, 7966.243206895336, 8079.959600202196, 9478.478683672189, 9480.146786789222, 9610.663626773308, 9641.27690423235, 9641.614335426784, 9814.116729494379, 9899.307048506535, 9994.250431217542, 10077.294589378673, 10155.54300056514, 6784.2876497967, 7221.097362829646, 7433.293837085685, 7577.583232922242, 7639.465237433326, 8151.877721834058, 8340.332773378237, 8384.496930184208, 8418.873716894374, 8431.241188293083, 7347.19180890091, 7492.70029198826, 7577.696892124253, 7588.582627955516, 7616.352610027988, 7322.3775979042375, 7325.340719335285, 7338.889916651361, 7360.263973602597, 7491.026166598307, 7796.025496812898, 7801.921980780119, 7802.726904558313, 7835.451518393657, 7844.333231675371, 7001.50989430735, 7010.263922288086, 7028.016077749221, 7043.295670432915, 7106.467014973794, 7114.50198486101, 7149.428045756223, 7152.177499587614, 7194.964025179841, 7238.493305468567], "unit": "score", "name": "mootools.html", "value": 4890.543446064506}, {"lowerIsBetter": false, "replicates": [320.7097576693092, 324.7840186276126, 328.9111939776259, 330.52239513902407, 334.6419331315492, 6802.421794147497, 6885.931140688592, 6951.131108611424, 6957.443404527645, 6992.091028166331, 6790.388865002149, 6798.694058767355, 6847.041414202015, 6857.828554286145, 6870.209925858528, 4824.734639594821, 4878.585320247783, 4981.0037992401485, 4982.651214414992, 5062.063518249127, 4968.776405061781, 4972.627052971042, 4979.128652485801, 4982.950170498285, 4987.251912213179, 4007.779572123532, 4942.665480320311, 4956.553910148086, 4987.800487980477, 4992.176290912013, 4114.670826333886, 4980.850574482772, 4982.202847544394, 4991.201407774775, 5004.699718016913, 4186.099988502456, 4276.593723596254, 4279.379489973936, 4287.078278170177, 4292.420523229355, 6307.148534947769, 6495.642739649317, 6554.1151944487365, 6565.54041217115, 6598.043283723881, 4691.62467002639, 4851.471786387312, 5868.0, 5955.285365756137, 5984.281886173643, 5956.106584012433, 7049.259827718119, 7196.208417074117, 7221.602811845346, 7254.492185547014, 4731.597814185799, 4761.47623761386, 4771.212749896263, 4779.737114458703, 4784.138855006132, 7632.351250143689, 7666.961665191694, 7689.923100768977, 7691.692332306701, 7719.112302085276, 4644.698094623838, 4835.6131509479155, 4853.975730121327, 4864.391951006124, 4899.853004409873, 4949.604031677457, 4955.2567114933045, 4966.577840883565, 4984.5513903748115, 4989.550940415307, 5869.06095024794, 5901.291844978544, 5903.675297858659, 5920.467157955804, 5922.911156332659, 7234.385077268385, 7261.782146535613, 7262.455315851333, 7273.89089163663, 7274.945132955691, 1712.220939472537, 1725.7325114607004, 1728.9481315560554, 1729.152715169558, 1734.913254337278, 1060.2260349944584, 1109.6892869996414, 1115.6151127860876, 1118.373710721982, 1126.898579127866, 6715.529912906148, 6762.289959554176, 6777.559458635173, 6788.253292137861, 6798.082258894986, 6028.728707208186, 7455.105387353444, 7546.169921308651, 7548.66031028605, 7563.7352692655495, 6487.837804054936, 6542.901856472156, 6722.260551339349, 6777.559458635272, 6799.4900382471515, 3419.4186988212064, 3961.9405708914387, 3993.860214892523, 4027.2549578328103, 4032.6169013943627, 7961.761147165595, 7966.84066318682, 7980.241877021674, 7993.440459167802, 8021.919780802234, 6344.0, 7533.886991695129, 7804.336631386395, 7825.100113486908, 7879.2120787921895, 7933.484323518953, 7953.32396746283, 7954.960225198837, 7969.8406031880195, 7973.282404583615, 7557.319841214317, 7580.54516728998, 7607.239276072349, 7611.733589324347, 7613.581253030915, 7432.814179645552, 7488.101427828696, 7598.544087354777, 7613.885791713018, 7621.009268795021, 7645.732399365996, 7917.129115797373, 7941.761747147595, 7959.363250940027, 7987.440879138405, 4293.506246781535, 4852.975735121302, 4881.585065269492, 4905.068037072945, 4930.728809915489, 6491.318411566717, 7177.641117943977, 7533.3973282138395, 7566.659500322608, 7597.772066838003, 6303.212098487689, 6810.250872403933, 7226.349628533457, 7322.5972571506945, 7369.705211791683, 7045.929540704732, 7290.526115802456, 7312.488125831141, 7326.157491888501, 7332.0834895638045, 6388.425041746265, 6404.615723056631, 7126.821829454305, 7140.036095127299, 7167.677454514664, 7301.707931682886, 7302.379297759538, 7329.010583571363, 7338.412926965723, 7344.265573442613, 7140.821479463055, 7162.570245785269, 7162.856742865009, 7170.42636589082, 7184.9640751795905], "unit": "score", "name": "prototype.html", "value": 5295.39261095959}, {"lowerIsBetter": false, "replicates": [685.054624618027, 685.4893104637047, 709.2659097833744, 749.2320371619093, 762.9885551716721, 15010.474633387834, 15044.0, 15106.320215590298, 15160.848391516081, 15185.39258429663, 13820.585382438543, 13918.373673184706, 13919.652008699788, 13960.860391396083, 14296.785548216785, 876.8465518534263, 913.853783394657, 913.8949020862586, 913.9771505712378, 916.8120535290283, 895.5074708910106, 901.6123067081153, 901.779064129286, 905.42053086025, 906.9138431848996, 935.4948327902924, 955.4649396338039, 956.7464621875208, 957.3681370295607, 957.4064080270207, 933.3186773655236, 949.8432758594823, 952.5475399185366, 953.0897992417225, 954.9236061115095, 678.7115475922714, 682.5120039172016, 683.0198664915862, 692.0449779304578, 693.2409012131708, 14325.713485730332, 14660.70678586433, 14725.190114543695, 14766.96631235814, 14768.113913165136, 12385.566505172366, 12421.503139874394, 12456.439460224312, 12529.812052819216, 12602.68493287666, 9869.457179855106, 9936.25478089139, 9962.953889841534, 9965.551550180187, 10277.126444252248, 3434.793912365266, 3484.1463841358777, 3491.0, 3518.7185025197923, 3588.4079126944025, 74527.0, 81817.77273340905, 82174.17825821725, 82958.0, 84168.57915710383, 8176.959115204386, 8695.739127826175, 9268.582913768896, 9410.811783764424, 9447.055294470498, 20176.69734953977, 20454.284100056426, 20477.692834607493, 20477.692834607493, 20493.487662808548, 7366.189719130892, 7488.138864030598, 7512.924870751332, 7566.924330756732, 7585.810354741176, 3998.200359928026, 4042.1915616876154, 4043.8584649537715, 4059.6346328830546, 4060.634542891154, 3619.6199399063244, 3652.726045546595, 3665.1203711109674, 3668.4680721295263, 3679.8344074516713, 654.8002859127917, 654.9574277672032, 674.6356967237734, 677.2786981864299, 680.6120511308507, 575.9654420734769, 578.2020811280406, 601.7141857617684, 608.7047781825811, 624.5503237668871, 8181.590920453954, 8232.917670823215, 8307.626156822958, 8388.328933685412, 8500.234978851933, 543.8069485332729, 545.6235197713565, 610.7892776991931, 610.9358517355614, 613.441767991126, 3616.5479315085613, 3828.712846536521, 3852.57621661617, 3931.6068393161027, 3956.0, 90030.0, 97116.54325185128, 97141.51429242949, 98843.0, 99174.00825991791, 70849.6457517709, 73185.0, 81085.59457202676, 82016.0, 82705.58647206725, 68347.0, 69043.0, 69537.0, 73167.63416182886, 73631.63184184044, 7581.128170260491, 7734.497257678233, 8212.589370531568, 8316.459430137264, 8332.208440198172, 48872.0, 50245.74877125591, 50301.0, 51477.22784158315, 51759.48240517547, 59264.0, 62936.055959159734, 71524.0, 71557.64221178861, 72933.0, 8698.739037828875, 10695.358278503314, 10795.784084318428, 11114.110871130451, 11624.593139240085, 12049.0, 12279.938600306941, 12384.256944583354, 12405.131640785059, 12473.812892806434, 11143.442827858413, 11339.773204536028, 11589.362585057903, 11640.01059909917, 11699.12256580777, 10742.409167495864, 10944.507497162487, 11380.772384552429, 11476.885231147582, 11789.0, 10912.727181820517, 11141.888581114084, 11194.608188713355, 11303.717407064889, 11591.710207244887, 9444.858327125236, 9676.419414835133, 9676.548517722398, 9782.364146330467, 9932.652357167464, 8662.35032372562, 8784.692535761218, 9354.29842761782, 9650.95174524123, 9652.662156824477], "unit": "score", "name": "yui.html", "value": 6892.744314596049}], "name": "dromaeo_css", "value": 7621.384153842632}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 111.0, 116.0, 115.0, 114.0, 129.0, 114.0, 115.0, 116.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.2}, {"lowerIsBetter": true, "replicates": [153.0, 138.0, 166.0, 191.0, 152.0, 138.0, 123.0, 192.0, 145.0, 153.0], "unit": "score", "name": "audio-beat-detection", "value": 155.1}, {"lowerIsBetter": true, "replicates": [193.0, 198.0, 227.0, 198.0, 265.0, 205.0, 285.0, 286.0, 212.0, 202.0], "unit": "score", "name": "audio-dft", "value": 227.1}, {"lowerIsBetter": true, "replicates": [72.0, 66.0, 74.0, 119.0, 66.0, 57.0, 51.0, 50.0, 117.0, 53.0], "unit": "score", "name": "audio-fft", "value": 72.5}, {"lowerIsBetter": true, "replicates": [82.0, 116.0, 157.0, 116.0, 92.0, 81.0, 116.0, 79.0, 81.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [94.0, 90.0, 86.0, 133.0, 137.0, 110.0, 93.0, 90.0, 91.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 101.3}, {"lowerIsBetter": true, "replicates": [142.0, 97.0, 96.0, 135.0, 96.0, 120.0, 153.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 113.0}, {"lowerIsBetter": true, "replicates": [151.0, 145.0, 90.0, 124.0, 145.0, 147.0, 101.0, 113.0, 145.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 125.3}, {"lowerIsBetter": true, "replicates": [50.0, 56.0, 68.0, 85.0, 87.0, 60.0, 58.0, 65.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 64.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 71.0, 69.0, 79.0, 75.0, 72.0, 69.0, 67.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 87.0, 85.0, 97.0, 117.0, 110.0, 106.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 94.6}, {"lowerIsBetter": true, "replicates": [139.0, 125.0, 130.0, 159.0, 146.0, 149.0, 112.0, 151.0, 136.0, 143.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 139.0}, {"lowerIsBetter": true, "replicates": [135.0, 185.0, 182.0, 148.0, 142.0, 138.0, 141.0, 144.0, 142.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 74.0, 81.0, 105.0, 96.0, 96.0, 77.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 80.3}], "name": "kraken", "value": 1610.6999999999996}]} 12:48:56 INFO - Return code: 0 12:48:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:48:56 ERROR - # TBPL SUCCESS # 12:48:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:48:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:48:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:48:56 INFO - 2016-03-24 12:48:56.255 screenresolution[1691:10361] starting screenresolution argv=screenresolution get 12:48:56 INFO - 2016-03-24 12:48:56.258 screenresolution[1691:10361] Display 0: 1600x1200x32@60 12:48:56 INFO - 2016-03-24 12:48:56.264 screenresolution[1692:10364] starting screenresolution argv=screenresolution list 12:48:56 INFO - Available Modes on Display 0 12:48:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:48:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:48:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:48:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:48:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:48:56 INFO - Intel Iris: 12:48:56 INFO - Chipset Model: Intel Iris 12:48:56 INFO - Type: GPU 12:48:56 INFO - Bus: Built-In 12:48:56 INFO - VRAM (Dynamic, Max): 1536 MB 12:48:56 INFO - Vendor: Intel (0x8086) 12:48:56 INFO - Device ID: 0x0a2e 12:48:56 INFO - Revision ID: 0x0009 12:48:56 INFO - Displays: 12:48:56 INFO - Display: 12:48:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:48:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:48:56 INFO - Display Serial Number: 1600x1200 60 12:48:56 INFO - Main Display: Yes 12:48:56 INFO - Mirror: Off 12:48:56 INFO - Online: Yes 12:48:56 INFO - Rotation: Supported 12:48:56 INFO - Return code: 0 12:48:56 INFO - Running post-action listener: _resource_record_post_action 12:48:56 INFO - Running post-run listener: _resource_record_post_run 12:48:57 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 34442752; Write bytes: 708710400; Read time: 364; Write time: 2007 12:48:57 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 398477824; Write bytes: 392738816; Read time: 31174; Write time: 754 12:48:57 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 32628224; Write bytes: 302839808; Read time: 343; Write time: 1219 12:48:57 INFO - Running post-run listener: _upload_blobber_files 12:48:57 INFO - Blob upload gear active. 12:48:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:48:57 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:48:57 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:48:57 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:48:57 INFO - (blobuploader) - INFO - Open directory for files ... 12:48:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:48:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:48:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:48:59 INFO - (blobuploader) - INFO - Done attempting. 12:48:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:48:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:49:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:00 INFO - (blobuploader) - INFO - Done attempting. 12:49:00 INFO - (blobuploader) - INFO - Iteration through files over. 12:49:00 INFO - Return code: 0 12:49:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:49:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:49:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4830713699bd0ec71c903abb7abad617e6bf8da98e1b5aa0e2b494d56969515c3f767c607e7715e567d00af9f4b3b7dfc24de982f4d6a66f4e034864917df5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef850cdf1903529997bae4108e6d7deefd28b743b63e9782730d4e2fbad136e7c3f0672f1b2835979b672e4db8a17aa765357e2736e973cb06fcad1be86e3dd6"} 12:49:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:49:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:49:00 INFO - Contents: 12:49:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4830713699bd0ec71c903abb7abad617e6bf8da98e1b5aa0e2b494d56969515c3f767c607e7715e567d00af9f4b3b7dfc24de982f4d6a66f4e034864917df5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef850cdf1903529997bae4108e6d7deefd28b743b63e9782730d4e2fbad136e7c3f0672f1b2835979b672e4db8a17aa765357e2736e973cb06fcad1be86e3dd6"} 12:49:00 INFO - Running post-run listener: copy_logs_to_upload_dir 12:49:00 INFO - Copying logs to upload dir... 12:49:00 INFO - mkdir: /builds/slave/test/build/upload/logs 12:49:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.982161 ========= master_lag: 3.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-03-24 12:49:03.165068) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 12:49:03.168410) ========= 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.GgXW74MXVG/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.wSendC4qe4/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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/Fx-Team/sha512/f4830713699bd0ec71c903abb7abad617e6bf8da98e1b5aa0e2b494d56969515c3f767c607e7715e567d00af9f4b3b7dfc24de982f4d6a66f4e034864917df5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef850cdf1903529997bae4108e6d7deefd28b743b63e9782730d4e2fbad136e7c3f0672f1b2835979b672e4db8a17aa765357e2736e973cb06fcad1be86e3dd6"} build_url:https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/R1C5syRVThWXw1GO1seI4A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4830713699bd0ec71c903abb7abad617e6bf8da98e1b5aa0e2b494d56969515c3f767c607e7715e567d00af9f4b3b7dfc24de982f4d6a66f4e034864917df5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef850cdf1903529997bae4108e6d7deefd28b743b63e9782730d4e2fbad136e7c3f0672f1b2835979b672e4db8a17aa765357e2736e973cb06fcad1be86e3dd6"}' ========= master_lag: 0.33 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 12:49:03.506058) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 14 secs) (at 2016-03-24 12:49:03.506385) ========= 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.GgXW74MXVG/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.wSendC4qe4/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005309 ========= master_lag: 14.52 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 14 secs) (at 2016-03-24 12:49:18.030577) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 12:49:18.030881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 12:49:18.463585) ========= ========= Total master_lag: 64.98 =========